builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-086 starttime: 1505375654.71 results: success (0) revision: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:14.714358) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:14.714917) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:14.715194) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:15.331977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:15.332286) ========= 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=438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 00:54:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2017-09-14 00:54:15 (46.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.204264 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:15.669278) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:15.677782) ========= 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=438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017255 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:15.761618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:15.761953) ========= 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=438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 00:54:15,873 truncating revision to first 12 chars 2017-09-14 00:54:15,873 Setting DEBUG logging. 2017-09-14 00:54:15,873 attempt 1/10 2017-09-14 00:54:15,873 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:16,181 unpacking tar archive at: mozilla-central-4702042aa919/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612262 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:16.447643) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:16.447957) ========= script_repo_revision: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:16.448333) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:16.452616) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 00:54:16.481164) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-14 00:54:16.481486) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:54:16 INFO - MultiFileLogger online at 20170914 00:54:16 in /builds/slave/test 00:54:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 00:54:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:54:16 INFO - {'append_to_log': False, 00:54:16 INFO - 'base_work_dir': '/builds/slave/test', 00:54:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 00:54:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:54:16 INFO - 'branch': 'Firefox-Non-PGO', 00:54:16 INFO - 'buildbot_json_path': 'buildprops.json', 00:54:16 INFO - 'code_coverage': False, 00:54:16 INFO - 'config_files': ('talos/linux_config.py',), 00:54:16 INFO - 'default_actions': ('clobber', 00:54:16 INFO - 'read-buildbot-config', 00:54:16 INFO - 'download-and-extract', 00:54:16 INFO - 'populate-webroot', 00:54:16 INFO - 'create-virtualenv', 00:54:16 INFO - 'install', 00:54:16 INFO - 'setup-mitmproxy', 00:54:16 INFO - 'run-tests'), 00:54:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:54:16 INFO - 'disable_ccov_upload': False, 00:54:16 INFO - 'disable_stylo': False, 00:54:16 INFO - 'download_minidump_stackwalk': True, 00:54:16 INFO - 'download_symbols': 'ondemand', 00:54:16 INFO - 'enable_stylo': False, 00:54:16 INFO - 'enable_webrender': False, 00:54:16 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 00:54:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:54:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:54:16 INFO - 'gecko_profile': False, 00:54:16 INFO - 'gecko_profile_interval': 0, 00:54:16 INFO - 'installer_path': 'installer.exe', 00:54:16 INFO - 'log_level': 'info', 00:54:16 INFO - 'log_name': 'talos', 00:54:16 INFO - 'log_to_console': True, 00:54:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:54:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:54:16 INFO - 'opt_config_files': (), 00:54:16 INFO - 'pip_index': False, 00:54:16 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 00:54:16 INFO - 'system_bits': '32', 00:54:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:54:16 INFO - 'title': 'talos-linux64-ix-086', 00:54:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:54:16 INFO - 'use_talos_json': True, 00:54:16 INFO - 'verify': 'False', 00:54:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:54:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:54:16 INFO - 'work_dir': 'build'} 00:54:16 INFO - [mozharness: 2017-09-14 07:54:16.782949Z] Running clobber step. 00:54:16 INFO - Running pre-action listener: _resource_record_pre_action 00:54:16 INFO - Running main action method: clobber 00:54:16 INFO - rmtree: /builds/slave/test/build 00:54:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:54:17 INFO - Running post-action listener: _resource_record_post_action 00:54:17 INFO - [mozharness: 2017-09-14 07:54:17.750135Z] Finished clobber step (success) 00:54:17 INFO - [mozharness: 2017-09-14 07:54:17.750239Z] Running read-buildbot-config step. 00:54:17 INFO - Running pre-action listener: _resource_record_pre_action 00:54:17 INFO - Running main action method: read_buildbot_config 00:54:17 INFO - Using buildbot properties: 00:54:17 INFO - { 00:54:17 INFO - "project": "", 00:54:17 INFO - "product": "firefox", 00:54:17 INFO - "who": "kwierso@gmail.com", 00:54:17 INFO - "installer_path": "public/build/target.tar.bz2", 00:54:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 00:54:17 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 00:54:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 00:54:17 INFO - "stage_platform": "linux64", 00:54:17 INFO - "basedir": "/builds/slave/test", 00:54:17 INFO - "buildnumber": 17, 00:54:17 INFO - "platform": "ubuntu64_hw", 00:54:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:54:17 INFO - "slavebuilddir": "test", 00:54:17 INFO - "taskId": "Vn4fJRiJQkCmnyU3XANW1A", 00:54:17 INFO - "branch": "mozilla-central", 00:54:17 INFO - "script_repo_revision": "production", 00:54:17 INFO - "revision": "4702042aa919d5ae49dfe3ac5ee86507839b3c83", 00:54:17 INFO - "slavename": "talos-linux64-ix-086", 00:54:17 INFO - "repo_path": "mozilla-central" 00:54:17 INFO - } 00:54:17 INFO - Finding installer, test and symbols from parent task. 00:54:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vn4fJRiJQkCmnyU3XANW1A'}, attempt #1 00:54:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vn4fJRiJQkCmnyU3XANW1A'}, attempt #1 00:54:18 INFO - Task dependencies: L_3yr4h9Spyt82QzKDJcnw 00:54:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw'}, attempt #1 00:54:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 00:54:19 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.test_packages.json 00:54:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.crashreporter-symbols.zip 00:54:19 INFO - Running post-action listener: _resource_record_post_action 00:54:19 INFO - [mozharness: 2017-09-14 07:54:19.232005Z] Finished read-buildbot-config step (success) 00:54:19 INFO - [mozharness: 2017-09-14 07:54:19.232222Z] Running download-and-extract step. 00:54:19 INFO - Running pre-action listener: _resource_record_pre_action 00:54:19 INFO - Running main action method: download_and_extract 00:54:19 INFO - mkdir: /builds/slave/test/build/tests 00:54:19 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:19 INFO - trying https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.test_packages.json 00:54:19 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:19 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:19 INFO - Downloaded 989 bytes. 00:54:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 00:54:19 INFO - Using the following test package requirements: 00:54:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 00:54:19 INFO - u'common': [u'target.common.tests.zip'], 00:54:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 00:54:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 00:54:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 00:54:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 00:54:19 INFO - u'mozbase': [u'target.common.tests.zip'], 00:54:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 00:54:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 00:54:19 INFO - u'web-platform': [u'target.common.tests.zip', 00:54:19 INFO - u'target.web-platform.tests.tar.gz'], 00:54:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 00:54:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 00:54:19 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:19 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:19 INFO - Fetch https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.common.tests.zip into memory 00:54:22 INFO - Content-Length response header: 54588745 00:54:22 INFO - Bytes received: 54588745 00:54:32 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:32 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:32 INFO - Fetch https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.talos.tests.zip into memory 00:54:34 INFO - Content-Length response header: 14500356 00:54:34 INFO - Bytes received: 14500356 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.tar.bz2 00:54:34 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:34 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:37 INFO - Downloaded 61305213 bytes. 00:54:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 00:54:37 INFO - mkdir: /builds/slave/test/properties 00:54:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:54:37 INFO - Writing to file /builds/slave/test/properties/build_url 00:54:37 INFO - Contents: 00:54:37 INFO - build_url:https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 00:54:37 INFO - Running post-action listener: _resource_record_post_action 00:54:37 INFO - Running post-action listener: find_tests_for_verification 00:54:37 INFO - Running post-action listener: set_extra_try_arguments 00:54:37 INFO - [mozharness: 2017-09-14 07:54:37.897269Z] Finished download-and-extract step (success) 00:54:37 INFO - [mozharness: 2017-09-14 07:54:37.897364Z] Running populate-webroot step. 00:54:37 INFO - Running pre-action listener: _resource_record_pre_action 00:54:37 INFO - Running main action method: populate_webroot 00:54:37 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:54:37 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:37 INFO - 'tests': ['tresize', 00:54:37 INFO - 'tcanvasmark']}, 00:54:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:54:37 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:37 INFO - 'tests': ['dromaeo_css', 00:54:37 INFO - 'kraken']}, 00:54:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:54:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:54:37 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:54:37 INFO - 'talos_options': ['--disable-stylo'], 00:54:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:54:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:54:37 INFO - 'tests': ['damp', 'tps']}, 00:54:37 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:54:37 INFO - 'talos_options': ['--disable-stylo'], 00:54:37 INFO - 'tests': ['damp', 'tps']}, 00:54:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:54:37 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:37 INFO - 'tests': ['dromaeo_dom']}, 00:54:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 00:54:37 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:37 INFO - 'tests': ['basic_compositor_video', 00:54:37 INFO - 'glvideo']}, 00:54:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 00:54:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 00:54:37 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:54:37 INFO - 'talos_options': ['--disable-stylo'], 00:54:37 INFO - 'tests': ['ts_paint_webext', 00:54:37 INFO - 'tp5o_webext']}, 00:54:37 INFO - 'other-e10s': {'tests': ['a11yr', 00:54:37 INFO - 'ts_paint', 00:54:37 INFO - 'tpaint', 00:54:37 INFO - 'sessionrestore', 00:54:37 INFO - 'sessionrestore_many_windows', 00:54:37 INFO - 'sessionrestore_no_auto_restore', 00:54:37 INFO - 'tabpaint']}, 00:54:37 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:37 INFO - 'tests': ['a11yr', 00:54:37 INFO - 'ts_paint', 00:54:37 INFO - 'tpaint', 00:54:37 INFO - 'sessionrestore', 00:54:37 INFO - 'sessionrestore_many_windows', 00:54:37 INFO - 'sessionrestore_no_auto_restore', 00:54:37 INFO - 'tabpaint']}, 00:54:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 00:54:37 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 00:54:37 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:37 INFO - 'tests': ['bloom_basic_singleton']}, 00:54:37 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:37 INFO - 'tests': ['bloom_basic']}, 00:54:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:54:37 INFO - 'tsvgr_opacity', 00:54:37 INFO - 'tart', 00:54:37 INFO - 'tscrollx', 00:54:37 INFO - 'tsvg_static']}, 00:54:37 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 00:54:37 INFO - 'tests': ['tsvgx', 00:54:37 INFO - 'tsvgr_opacity', 00:54:37 INFO - 'tart', 00:54:37 INFO - 'tscrollx', 00:54:37 INFO - 'tsvg_static']}, 00:54:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:54:37 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:54:37 INFO - 'talos_options': ['--disable-stylo'], 00:54:37 INFO - 'tests': ['tp5o']}, 00:54:37 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:54:37 INFO - 'talos_options': ['--mitmproxy', 00:54:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:54:37 INFO - '--firstNonBlankPaint'], 00:54:37 INFO - 'tests': ['tp6_google', 00:54:37 INFO - 'tp6_youtube', 00:54:37 INFO - 'tp6_amazon', 00:54:37 INFO - 'tp6_facebook']}, 00:54:37 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:54:37 INFO - 'talos_options': ['--disable-stylo', 00:54:37 INFO - '--mitmproxy', 00:54:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:54:37 INFO - '--firstNonBlankPaint'], 00:54:37 INFO - 'tests': ['tp6_google', 00:54:37 INFO - 'tp6_youtube', 00:54:37 INFO - 'tp6_amazon', 00:54:37 INFO - 'tp6_facebook']}, 00:54:37 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:54:37 INFO - 'talos_options': ['--stylo-threads=1', 00:54:37 INFO - '--mitmproxy', 00:54:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:54:37 INFO - '--firstNonBlankPaint'], 00:54:37 INFO - 'tests': ['tp6_google', 00:54:37 INFO - 'tp6_youtube', 00:54:37 INFO - 'tp6_amazon', 00:54:37 INFO - 'tp6_facebook']}, 00:54:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:54:37 INFO - 'talos_options': ['--xperf_path', 00:54:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:54:37 INFO - 'tests': ['tp5n']}, 00:54:37 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 00:54:37 INFO - 'talos_options': ['--disable-stylo', 00:54:37 INFO - '--xperf_path', 00:54:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:54:37 INFO - 'tests': ['tp5n']}}} 00:54:37 INFO - Running post-action listener: _resource_record_post_action 00:54:37 INFO - [mozharness: 2017-09-14 07:54:37.912291Z] Finished populate-webroot step (success) 00:54:37 INFO - [mozharness: 2017-09-14 07:54:37.912380Z] Running create-virtualenv step. 00:54:37 INFO - Running pre-action listener: _resource_record_pre_action 00:54:37 INFO - Running main action method: create_virtualenv 00:54:37 INFO - Creating virtualenv /builds/slave/test/build/venv 00:54:37 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:54:37 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 00:54:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 00:54:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:54:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:54:38 INFO - Installing distribute.............................................................................................................................................................................................done. 00:54:39 INFO - Installing pip...............done. 00:54:39 INFO - Return code: 0 00:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:54:39 INFO - Reading from file tmpfile_stdout 00:54:39 INFO - Output received: 00:54:39 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:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:54:39 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:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:39 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:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:39 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 0x15651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5090>, '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 0x18d5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18cff90>, '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': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', '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:39 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:39 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:39 INFO - Using env: {'DISPLAY': ':0', 00:54:39 INFO - 'HOME': '/home/cltbld', 00:54:39 INFO - 'LANG': 'en_US.UTF-8', 00:54:39 INFO - 'LANGUAGE': 'en_US:en', 00:54:39 INFO - 'LOGNAME': 'cltbld', 00:54:39 INFO - 'MAIL': '/var/mail/cltbld', 00:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:39 INFO - 'MOZ_NO_REMOTE': '1', 00:54:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:39 INFO - 'NO_EM_RESTART': '1', 00:54:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:39 INFO - 'PWD': '/builds/slave/test', 00:54:39 INFO - 'SHELL': '/bin/bash', 00:54:39 INFO - 'SHLVL': '1', 00:54:39 INFO - 'TERM': 'linux', 00:54:39 INFO - 'TMOUT': '86400', 00:54:39 INFO - 'USER': 'cltbld', 00:54:39 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', 00:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:39 INFO - '_': '/tools/buildbot/bin/python'} 00:54:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 00:54:40 INFO - Downloading/unpacking pip>=1.5 00:54:40 INFO - Running setup.py egg_info for package pip 00:54:40 INFO - warning: no files found matching 'pip/cacert.pem' 00:54:40 INFO - warning: no files found matching '*.html' under directory 'docs' 00:54:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 00:54:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 00:54:40 INFO - Installing collected packages: pip 00:54:40 INFO - Found existing installation: pip 1.1 00:54:40 INFO - Uninstalling pip: 00:54:40 INFO - Successfully uninstalled pip 00:54:40 INFO - Running setup.py install for pip 00:54:40 INFO - warning: no files found matching 'pip/cacert.pem' 00:54:40 INFO - warning: no files found matching '*.html' under directory 'docs' 00:54:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 00:54:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 00:54:40 INFO - Installing pip script to /builds/slave/test/build/venv/bin 00:54:40 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 00:54:40 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 00:54:40 INFO - Successfully installed pip 00:54:40 INFO - Cleaning up... 00:54:40 INFO - Return code: 0 00:54:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5090>, '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 0x18d5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18cff90>, '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': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', '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:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:54:40 INFO - Using env: {'DISPLAY': ':0', 00:54:40 INFO - 'HOME': '/home/cltbld', 00:54:40 INFO - 'LANG': 'en_US.UTF-8', 00:54:40 INFO - 'LANGUAGE': 'en_US:en', 00:54:40 INFO - 'LOGNAME': 'cltbld', 00:54:40 INFO - 'MAIL': '/var/mail/cltbld', 00:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:40 INFO - 'MOZ_NO_REMOTE': '1', 00:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:40 INFO - 'NO_EM_RESTART': '1', 00:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:40 INFO - 'PWD': '/builds/slave/test', 00:54:40 INFO - 'SHELL': '/bin/bash', 00:54:40 INFO - 'SHLVL': '1', 00:54:40 INFO - 'TERM': 'linux', 00:54:40 INFO - 'TMOUT': '86400', 00:54:40 INFO - 'USER': 'cltbld', 00:54:40 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', 00:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:40 INFO - '_': '/tools/buildbot/bin/python'} 00:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:41 INFO - Downloading/unpacking psutil>=3.1.1 00:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:54:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:54:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:54:42 INFO - Installing collected packages: psutil 00:54:42 INFO - Running setup.py install for psutil 00:54:42 INFO - building 'psutil._psutil_linux' extension 00:54:42 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:43 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:43 INFO - building 'psutil._psutil_posix' extension 00:54:43 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:43 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:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:54:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:54:44 INFO - Successfully installed psutil 00:54:44 INFO - Cleaning up... 00:54:44 INFO - Return code: 0 00:54:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:44 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 0x15651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5090>, '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 0x18d5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18cff90>, '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': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', '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:44 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:44 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:44 INFO - Using env: {'DISPLAY': ':0', 00:54:44 INFO - 'HOME': '/home/cltbld', 00:54:44 INFO - 'LANG': 'en_US.UTF-8', 00:54:44 INFO - 'LANGUAGE': 'en_US:en', 00:54:44 INFO - 'LOGNAME': 'cltbld', 00:54:44 INFO - 'MAIL': '/var/mail/cltbld', 00:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:44 INFO - 'MOZ_NO_REMOTE': '1', 00:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:44 INFO - 'NO_EM_RESTART': '1', 00:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:44 INFO - 'PWD': '/builds/slave/test', 00:54:44 INFO - 'SHELL': '/bin/bash', 00:54:44 INFO - 'SHLVL': '1', 00:54:44 INFO - 'TERM': 'linux', 00:54:44 INFO - 'TMOUT': '86400', 00:54:44 INFO - 'USER': 'cltbld', 00:54:44 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', 00:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:44 INFO - '_': '/tools/buildbot/bin/python'} 00:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:54:45 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:45 INFO - Installing collected packages: mozsystemmonitor 00:54:45 INFO - Running setup.py install for mozsystemmonitor 00:54:45 INFO - Successfully installed mozsystemmonitor 00:54:45 INFO - Cleaning up... 00:54:45 INFO - Return code: 0 00:54:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5090>, '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 0x18d5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18cff90>, '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': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', '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:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:54:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:54:45 INFO - Using env: {'DISPLAY': ':0', 00:54:45 INFO - 'HOME': '/home/cltbld', 00:54:45 INFO - 'LANG': 'en_US.UTF-8', 00:54:45 INFO - 'LANGUAGE': 'en_US:en', 00:54:45 INFO - 'LOGNAME': 'cltbld', 00:54:45 INFO - 'MAIL': '/var/mail/cltbld', 00:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:45 INFO - 'MOZ_NO_REMOTE': '1', 00:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:45 INFO - 'NO_EM_RESTART': '1', 00:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:45 INFO - 'PWD': '/builds/slave/test', 00:54:45 INFO - 'SHELL': '/bin/bash', 00:54:45 INFO - 'SHLVL': '1', 00:54:45 INFO - 'TERM': 'linux', 00:54:45 INFO - 'TMOUT': '86400', 00:54:45 INFO - 'USER': 'cltbld', 00:54:45 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', 00:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:45 INFO - '_': '/tools/buildbot/bin/python'} 00:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:45 INFO - Downloading/unpacking jsonschema==2.5.1 00:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:54:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:54:46 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:46 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:46 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:46 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:47 INFO - Downloading functools32-3.2.3-2.tar.gz 00:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:54:47 INFO - warning: no files found matching '*.txt' 00:54:47 INFO - no previously-included directories found matching 'build' 00:54:47 INFO - no previously-included directories found matching 'dist' 00:54:47 INFO - no previously-included directories found matching '.git*' 00:54:47 INFO - Installing collected packages: jsonschema, functools32 00:54:47 INFO - Running setup.py install for functools32 00:54:47 INFO - warning: no files found matching '*.txt' 00:54:47 INFO - no previously-included directories found matching 'build' 00:54:47 INFO - no previously-included directories found matching 'dist' 00:54:47 INFO - no previously-included directories found matching '.git*' 00:54:47 INFO - Successfully installed jsonschema functools32 00:54:47 INFO - Cleaning up... 00:54:47 INFO - Return code: 0 00:54:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5090>, '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 0x18d5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18cff90>, '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': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', '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:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:54:47 INFO - Using env: {'DISPLAY': ':0', 00:54:47 INFO - 'HOME': '/home/cltbld', 00:54:47 INFO - 'LANG': 'en_US.UTF-8', 00:54:47 INFO - 'LANGUAGE': 'en_US:en', 00:54:47 INFO - 'LOGNAME': 'cltbld', 00:54:47 INFO - 'MAIL': '/var/mail/cltbld', 00:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:47 INFO - 'MOZ_NO_REMOTE': '1', 00:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:47 INFO - 'NO_EM_RESTART': '1', 00:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:47 INFO - 'PWD': '/builds/slave/test', 00:54:47 INFO - 'SHELL': '/bin/bash', 00:54:47 INFO - 'SHLVL': '1', 00:54:47 INFO - 'TERM': 'linux', 00:54:47 INFO - 'TMOUT': '86400', 00:54:47 INFO - 'USER': 'cltbld', 00:54:47 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', 00:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:47 INFO - '_': '/tools/buildbot/bin/python'} 00:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:54:47 INFO - Cleaning up... 00:54:47 INFO - Return code: 0 00:54:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5090>, '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 0x18d5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18cff90>, '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': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', '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:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:54:47 INFO - Using env: {'DISPLAY': ':0', 00:54:47 INFO - 'HOME': '/home/cltbld', 00:54:47 INFO - 'LANG': 'en_US.UTF-8', 00:54:47 INFO - 'LANGUAGE': 'en_US:en', 00:54:47 INFO - 'LOGNAME': 'cltbld', 00:54:47 INFO - 'MAIL': '/var/mail/cltbld', 00:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:47 INFO - 'MOZ_NO_REMOTE': '1', 00:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:47 INFO - 'NO_EM_RESTART': '1', 00:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:47 INFO - 'PWD': '/builds/slave/test', 00:54:47 INFO - 'SHELL': '/bin/bash', 00:54:47 INFO - 'SHLVL': '1', 00:54:47 INFO - 'TERM': 'linux', 00:54:47 INFO - 'TMOUT': '86400', 00:54:47 INFO - 'USER': 'cltbld', 00:54:47 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', 00:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:47 INFO - '_': '/tools/buildbot/bin/python'} 00:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:47 INFO - Downloading/unpacking blobuploader==1.2.4 00:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:48 INFO - Downloading blobuploader-1.2.4.tar.gz 00:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:54:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:54:48 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:48 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:48 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:48 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:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:54:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:49 INFO - Downloading docopt-0.6.1.tar.gz 00:54:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:54:49 INFO - Installing collected packages: blobuploader, requests, docopt 00:54:49 INFO - Running setup.py install for blobuploader 00:54:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:54:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:54:49 INFO - Running setup.py install for requests 00:54:49 INFO - Running setup.py install for docopt 00:54:49 INFO - Successfully installed blobuploader requests docopt 00:54:49 INFO - Cleaning up... 00:54:50 INFO - Return code: 0 00:54:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:50 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 0x15651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5090>, '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 0x18d5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18cff90>, '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': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', '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:50 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:54:50 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:54:50 INFO - Using env: {'DISPLAY': ':0', 00:54:50 INFO - 'HOME': '/home/cltbld', 00:54:50 INFO - 'LANG': 'en_US.UTF-8', 00:54:50 INFO - 'LANGUAGE': 'en_US:en', 00:54:50 INFO - 'LOGNAME': 'cltbld', 00:54:50 INFO - 'MAIL': '/var/mail/cltbld', 00:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:50 INFO - 'MOZ_NO_REMOTE': '1', 00:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:50 INFO - 'NO_EM_RESTART': '1', 00:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:50 INFO - 'PWD': '/builds/slave/test', 00:54:50 INFO - 'SHELL': '/bin/bash', 00:54:50 INFO - 'SHLVL': '1', 00:54:50 INFO - 'TERM': 'linux', 00:54:50 INFO - 'TMOUT': '86400', 00:54:50 INFO - 'USER': 'cltbld', 00:54:50 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', 00:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:50 INFO - '_': '/tools/buildbot/bin/python'} 00:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:54:50 INFO - Running setup.py (path:/tmp/pip-ZFMqYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:54:50 INFO - Running setup.py (path:/tmp/pip-xEagqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:54:50 INFO - Running setup.py (path:/tmp/pip-4h1tdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:54:50 INFO - Running setup.py (path:/tmp/pip-1dd2oO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:54:50 INFO - Running setup.py (path:/tmp/pip-PGFxtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:54:50 INFO - Running setup.py (path:/tmp/pip-ZenV3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:54:50 INFO - Running setup.py (path:/tmp/pip-zFS0sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:54:50 INFO - Running setup.py (path:/tmp/pip-I_ty2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:54:50 INFO - Running setup.py (path:/tmp/pip-13jgWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:54:50 INFO - Running setup.py (path:/tmp/pip-IY4HAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:54:50 INFO - Running setup.py (path:/tmp/pip-z9LMfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:54:51 INFO - Running setup.py (path:/tmp/pip-rp5pWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:54:51 INFO - Running setup.py (path:/tmp/pip-UQkE28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:54:51 INFO - Running setup.py (path:/tmp/pip-VrmGuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:54:51 INFO - Running setup.py (path:/tmp/pip-Rjj92B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:54:51 INFO - Running setup.py (path:/tmp/pip-5Sjm51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:54:51 INFO - Running setup.py (path:/tmp/pip-yzrQT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:54:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:54:51 INFO - Running setup.py install for manifestparser 00:54:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:54:51 INFO - Running setup.py install for mozcrash 00:54:51 INFO - Running setup.py install for mozdebug 00:54:51 INFO - Running setup.py install for mozdevice 00:54:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:54:51 INFO - Running setup.py install for mozfile 00:54:51 INFO - Running setup.py install for mozhttpd 00:54:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:54:52 INFO - Running setup.py install for mozinfo 00:54:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:54:52 INFO - Running setup.py install for mozInstall 00:54:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:54:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:54:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:54:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:54:52 INFO - Running setup.py install for mozleak 00:54:52 INFO - Running setup.py install for mozlog 00:54:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:54:52 INFO - Running setup.py install for moznetwork 00:54:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:54:52 INFO - Running setup.py install for mozprocess 00:54:52 INFO - Running setup.py install for mozprofile 00:54:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:54:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:54:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:54:52 INFO - Running setup.py install for mozrunner 00:54:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:54:52 INFO - Running setup.py install for mozscreenshot 00:54:52 INFO - Running setup.py install for moztest 00:54:53 INFO - Running setup.py install for mozversion 00:54:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:54:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:54:53 INFO - Cleaning up... 00:54:53 INFO - Return code: 0 00:54:53 INFO - Installing None 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', '-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 0x15651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5090>, '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 0x18d5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18cff90>, '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': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', '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', '-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:54:53 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: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': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:54:53 INFO - Running setup.py (path:/tmp/pip-U7Wzc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:54:53 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:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:54:53 INFO - Running setup.py (path:/tmp/pip-02HR7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:54:53 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:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:54:53 INFO - Running setup.py (path:/tmp/pip-1397_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:54:53 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:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:54:53 INFO - Running setup.py (path:/tmp/pip-O3B6rA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:54:53 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:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:54:53 INFO - Running setup.py (path:/tmp/pip-PKapD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:54:53 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:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:54:53 INFO - Running setup.py (path:/tmp/pip-nVK7vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:54:53 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:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:54:53 INFO - Running setup.py (path:/tmp/pip-3PVAz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:54:53 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:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:54:53 INFO - Running setup.py (path:/tmp/pip-NeZv2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:54:53 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:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:54:53 INFO - Running setup.py (path:/tmp/pip-bHzWuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:54:54 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:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:54:54 INFO - Running setup.py (path:/tmp/pip-3eK_yV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:54:54 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:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:54:54 INFO - Running setup.py (path:/tmp/pip-lCOeF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:54:54 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:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:54:54 INFO - Running setup.py (path:/tmp/pip-By02BX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:54:54 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:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:54:54 INFO - Running setup.py (path:/tmp/pip-hwghOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:54:54 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:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:54:54 INFO - Running setup.py (path:/tmp/pip-Y8CTe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:54:54 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:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:54:54 INFO - Running setup.py (path:/tmp/pip-rTHJGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:54:54 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:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:54:54 INFO - Running setup.py (path:/tmp/pip-9kaxYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:54:54 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:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:54:54 INFO - Running setup.py (path:/tmp/pip-dQDaD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:54:54 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:54:54 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:54:54 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:54:54 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:54:54 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:54:54 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:54:54 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:54:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:54:55 INFO - Downloading blessings-1.6.tar.gz 00:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:54:55 INFO - Installing collected packages: blessings 00:54:55 INFO - Running setup.py install for blessings 00:54:55 INFO - Successfully installed blessings 00:54:55 INFO - Cleaning up... 00:54:55 INFO - Return code: 0 00:54:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:54:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:54:56 INFO - Reading from file tmpfile_stdout 00:54:56 INFO - Current package versions: 00:54:56 INFO - argparse == 1.2.1 00:54:56 INFO - blessings == 1.6 00:54:56 INFO - blobuploader == 1.2.4 00:54:56 INFO - docopt == 0.6.1 00:54:56 INFO - functools32 == 3.2.3-2 00:54:56 INFO - jsonschema == 2.5.1 00:54:56 INFO - manifestparser == 1.1 00:54:56 INFO - mozInstall == 1.13 00:54:56 INFO - mozcrash == 1.0 00:54:56 INFO - mozdebug == 0.1 00:54:56 INFO - mozdevice == 0.51 00:54:56 INFO - mozfile == 1.2 00:54:56 INFO - mozhttpd == 0.7 00:54:56 INFO - mozinfo == 0.10 00:54:56 INFO - mozleak == 0.1 00:54:56 INFO - mozlog == 3.5 00:54:56 INFO - moznetwork == 0.27 00:54:56 INFO - mozprocess == 0.25 00:54:56 INFO - mozprofile == 0.28 00:54:56 INFO - mozrunner == 6.13 00:54:56 INFO - mozscreenshot == 0.1 00:54:56 INFO - mozsystemmonitor == 0.3 00:54:56 INFO - moztest == 0.8 00:54:56 INFO - mozversion == 1.4 00:54:56 INFO - psutil == 3.1.1 00:54:56 INFO - requests == 1.2.3 00:54:56 INFO - wsgiref == 0.1.2 00:54:56 INFO - Installing None 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', '-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 0x15651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5090>, '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 0x18d5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18cff90>, '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': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', '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', '-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:54:56 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: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': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', 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 - 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:54:56 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:54:56 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:54:56 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:54:56 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:54:56 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:54:56 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:54:56 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:54:56 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:54:56 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 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 - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 00:54:57 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:54:57 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:54:57 INFO - Installing collected packages: simplejson 00:54:57 INFO - Running setup.py install for simplejson 00:54:57 INFO - building 'simplejson._speedups' extension 00:54:57 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:54:58 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:54:58 INFO - Successfully installed simplejson 00:54:58 INFO - Cleaning up... 00:54:58 INFO - Return code: 0 00:54:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:54:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:54:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d1a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5090>, '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 0x18d5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18cff90>, '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': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', '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:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:54:58 INFO - Using env: {'DISPLAY': ':0', 00:54:58 INFO - 'HOME': '/home/cltbld', 00:54:58 INFO - 'LANG': 'en_US.UTF-8', 00:54:58 INFO - 'LANGUAGE': 'en_US:en', 00:54:58 INFO - 'LOGNAME': 'cltbld', 00:54:58 INFO - 'MAIL': '/var/mail/cltbld', 00:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:54:58 INFO - 'MOZ_NO_REMOTE': '1', 00:54:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:54:58 INFO - 'NO_EM_RESTART': '1', 00:54:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:54:58 INFO - 'PWD': '/builds/slave/test', 00:54:58 INFO - 'SHELL': '/bin/bash', 00:54:58 INFO - 'SHLVL': '1', 00:54:58 INFO - 'TERM': 'linux', 00:54:58 INFO - 'TMOUT': '86400', 00:54:58 INFO - 'USER': 'cltbld', 00:54:58 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', 00:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:54:58 INFO - '_': '/tools/buildbot/bin/python'} 00:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:54:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:54:58 INFO - Cleaning up... 00:54:58 INFO - Return code: 0 00:54:58 INFO - Running post-action listener: _resource_record_post_action 00:54:58 INFO - Running post-action listener: _start_resource_monitoring 00:54:58 INFO - Starting resource monitoring. 00:54:58 INFO - [mozharness: 2017-09-14 07:54:58.954636Z] Finished create-virtualenv step (success) 00:54:58 INFO - [mozharness: 2017-09-14 07:54:58.955575Z] Running install step. 00:54:58 INFO - Running pre-action listener: _resource_record_pre_action 00:54:58 INFO - Running main action method: install 00:54:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:54:59 INFO - Reading from file tmpfile_stdout 00:54:59 INFO - Detecting whether we're running mozinstall >=1.0... 00:54:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:54:59 INFO - Reading from file tmpfile_stdout 00:54:59 INFO - Output received: 00:54:59 INFO - Usage: mozinstall [options] installer 00:54:59 INFO - Options: 00:54:59 INFO - -h, --help show this help message and exit 00:54:59 INFO - -d DEST, --destination=DEST 00:54:59 INFO - Directory to install application into. [default: 00:54:59 INFO - "/builds/slave/test"] 00:54:59 INFO - --app=APP Application being installed. [default: firefox] 00:54:59 INFO - mkdir: /builds/slave/test/build/application 00:54:59 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:54:59 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:17 INFO - Reading from file tmpfile_stdout 00:55:17 INFO - Output received: 00:55:17 INFO - /builds/slave/test/build/application/firefox/firefox 00:55:17 INFO - Running post-action listener: _resource_record_post_action 00:55:17 INFO - [mozharness: 2017-09-14 07:55:17.026755Z] Finished install step (success) 00:55:17 INFO - [mozharness: 2017-09-14 07:55:17.027096Z] Running setup-mitmproxy step. 00:55:17 INFO - Running pre-action listener: _resource_record_pre_action 00:55:17 INFO - Running main action method: setup_mitmproxy 00:55:17 INFO - Skipping: mitmproxy is not required 00:55:17 INFO - Running post-action listener: _resource_record_post_action 00:55:17 INFO - [mozharness: 2017-09-14 07:55:17.028710Z] Finished setup-mitmproxy step (success) 00:55:17 INFO - [mozharness: 2017-09-14 07:55:17.029022Z] Running run-tests step. 00:55:17 INFO - Running pre-action listener: _resource_record_pre_action 00:55:17 INFO - Running pre-action listener: _set_gcov_prefix 00:55:17 INFO - Running main action method: run_tests 00:55:17 WARNING - Try message not found. 00:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:55:17 INFO - Python 2.7.3 00:55:17 INFO - Return code: 0 00:55:17 INFO - grabbing minidump binary from tooltool 00:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:55:17 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 0x18d5090>, '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 0x18d5d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18cff90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:55:17 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:17 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:17 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:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:55:17 INFO - Return code: 0 00:55:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:55:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:55:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:55:17 INFO - ENV: RUST_BACKTRACE is now full 00:55:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:55:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-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-086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 00:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-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-086 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 00:55:17 INFO - Using env: {'DISPLAY': ':0', 00:55:17 INFO - 'HOME': '/home/cltbld', 00:55:17 INFO - 'LANG': 'en_US.UTF-8', 00:55:17 INFO - 'LANGUAGE': 'en_US:en', 00:55:17 INFO - 'LOGNAME': 'cltbld', 00:55:17 INFO - 'MAIL': '/var/mail/cltbld', 00:55:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:55:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:17 INFO - 'MOZ_NO_REMOTE': '1', 00:55:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:17 INFO - 'NO_EM_RESTART': '1', 00:55:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:17 INFO - 'PWD': '/builds/slave/test', 00:55:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:55:17 INFO - 'RUST_BACKTRACE': 'full', 00:55:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:55:17 INFO - 'SHELL': '/bin/bash', 00:55:17 INFO - 'SHLVL': '1', 00:55:17 INFO - 'TERM': 'linux', 00:55:17 INFO - 'TMOUT': '86400', 00:55:17 INFO - 'USER': 'cltbld', 00:55:17 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', 00:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:17 INFO - '_': '/tools/buildbot/bin/python'} 00:55:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-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-086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 00:55:17 INFO - mozversion application_buildid: 20170914070342 00:55:17 INFO - mozversion application_changeset: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 00:55:17 INFO - mozversion application_display_name: Nightly 00:55:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:55:17 INFO - mozversion application_name: Firefox 00:55:17 INFO - mozversion application_remotingname: firefox 00:55:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:55:17 INFO - mozversion application_vendor: Mozilla 00:55:17 INFO - mozversion application_version: 57.0a1 00:55:17 INFO - mozversion platform_buildid: 20170914070342 00:55:17 INFO - mozversion platform_changeset: 4702042aa919d5ae49dfe3ac5ee86507839b3c83 00:55:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:55:17 INFO - mozversion platform_version: 57.0a1 00:55:17 INFO - using testdate: 1505375717 00:55:17 INFO - actual date: 1505375717 00:55:17 INFO - starting webserver on 'localhost:50632' 00:55:17 INFO - SUITE-START | Running 2 tests 00:55:17 INFO - TEST-START | dromaeo_css 00:55:17 INFO - Initialising browser for dromaeo_css test... 00:55:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50632/getInfo.html -profile /tmp/tmpZKuEj6/profile 00:55:17 INFO - TEST-INFO | started process 3551 (/builds/slave/test/build/application/firefox/firefox http://localhost:50632/getInfo.html) 00:55:25 INFO - TEST-INFO | 3551: exit 0 00:55:25 INFO - Browser initialized. 00:55:25 INFO - Running cycle 1/1 for dromaeo_css test... 00:55:25 INFO - Using env: {'DISPLAY': ':0', 00:55:25 INFO - 'HOME': '/home/cltbld', 00:55:25 INFO - 'JSGC_DISABLE_POISONING': '1', 00:55:25 INFO - 'LANG': 'en_US.UTF-8', 00:55:25 INFO - 'LANGUAGE': 'en_US:en', 00:55:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 00:55:25 INFO - 'LOGNAME': 'cltbld', 00:55:25 INFO - 'MAIL': '/var/mail/cltbld', 00:55:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:55:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:55:25 INFO - 'MOZ_CRASHREPORTER': '1', 00:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:55:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 00:55:25 INFO - 'MOZ_NO_REMOTE': '1', 00:55:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:55:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:55:25 INFO - 'NO_EM_RESTART': '1', 00:55:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:55:25 INFO - 'PWD': '/builds/slave/test', 00:55:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:55:25 INFO - 'RUST_BACKTRACE': 'full', 00:55:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:55:25 INFO - 'SHELL': '/bin/bash', 00:55:25 INFO - 'SHLVL': '1', 00:55:25 INFO - 'STYLO_FORCE_DISABLED': '1', 00:55:25 INFO - 'TERM': 'linux', 00:55:25 INFO - 'TMOUT': '86400', 00:55:25 INFO - 'USER': 'cltbld', 00:55:25 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', 00:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:55:25 INFO - '_': '/tools/buildbot/bin/python'} 00:55:25 INFO - TEST-INFO | started process 3781 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZKuEj6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:55:26 INFO - PID 3781 | 00:55:26 INFO - PID 3781 | (/builds/slave/test/build/application/firefox/firefox:3830): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:55:26 INFO - PID 3781 | 00:55:36 INFO - PID 3781 | RSS: Main: 172642304 00:55:36 INFO - PID 3781 | 00:58:34 INFO - PID 3781 | Cycle 1(1): loaded http://localhost:50632/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50632/tests/dromaeo/cssquery-ext.html) 00:58:35 INFO - PID 3781 | RSS: Main: 175710208 00:58:35 INFO - PID 3781 | 01:01:37 INFO - PID 3781 | Cycle 1(1): loaded http://localhost:50632/tests/dromaeo/cssquery-ext.html (next: http://localhost:50632/tests/dromaeo/cssquery-jquery.html) 01:01:38 INFO - PID 3781 | RSS: Main: 172081152 01:01:38 INFO - PID 3781 | 01:04:39 INFO - PID 3781 | Cycle 1(1): loaded http://localhost:50632/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50632/tests/dromaeo/cssquery-mootools.html) 01:04:40 INFO - PID 3781 | RSS: Main: 173015040 01:04:40 INFO - PID 3781 | 01:07:42 INFO - PID 3781 | Cycle 1(1): loaded http://localhost:50632/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50632/tests/dromaeo/cssquery-prototype.html) 01:07:42 INFO - PID 3781 | RSS: Main: 172507136 01:07:42 INFO - PID 3781 | 01:10:46 INFO - PID 3781 | Cycle 1(1): loaded http://localhost:50632/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50632/tests/dromaeo/cssquery-yui.html) 01:10:46 INFO - PID 3781 | RSS: Main: 172445696 01:10:46 INFO - PID 3781 | 01:13:48 INFO - PID 3781 | Cycle 1(1): loaded http://localhost:50632/tests/dromaeo/cssquery-yui.html (next: http://localhost:50632/tests/dromaeo/cssquery-dojo.html) 01:13:48 INFO - PID 3781 | RSS: Main: 176889856 01:13:48 INFO - PID 3781 | 01:13:48 INFO - PID 3781 | __start_tp_report 01:13:48 INFO - PID 3781 | _x_x_mozilla_page_load 01:13:48 INFO - PID 3781 | _x_x_mozilla_page_load_details 01:13:48 INFO - PID 3781 | |i|pagename|runs| 01:13:48 INFO - PID 3781 | |0;dojo.html;3113.844307784611;3158.4156930967756;3186.1238159506124;3198.424283628946;3226.709596136349;6238.812835614927;6355.586886852351;6394.008928616066;6422.967885160573;6486.416222539976;6300;6350.904736428957;6356.713947872346;6362.650054247015;6374.04389341599;5796.855078623026;5807.535397168216;5812.331581868087;5860.736266868002;5930.940690593104;5916.2900451945825;5920.141579470974;5937.109433584975;5960.135780311853;5973.253343332083;5756.971215143918;5835.533275986517;5912.113183022538;5929.584929054968;5950.761969521214;5641.125625528009;5670.461306175906;5773.769049238025;5848.5321174305955;5881.529477641779;5766.769329226826;5800.622959507661;5840.065589505702;5842.912356314659;5900.026495628216;6161.784337548164;6233.625982441068;6273.0904018917;6350.904736428957;6448.967755161194;6645.1361323027695;6681.098051762999;6684.632345221011;6725.461963042993;6819.931800681979;6901.827454313632;6959.269276725921;6977.1278590176225;6984.196817365966;6993.930060699429;6373.42639162473;6381.042843573455;6456.612603243821;6468.902966455507;6476.481881449426;6852.6916288767125;6939.30606939302;6939.514234003571;6945.374916257561;6951.89572156418;6539.2479864815205;6603.867922641521;6623.9006414903815;6625.105610742585;6638.86722265552;6722.495812814059;6797.524173307821;6933.375996160269;6953.304669533108;6953.548019378724;6800.795976120724;6806.625635589991;6891.965540172267;6901.378875901193;6903.1371078615175;6601.3728695773825;6863.862722745517;6874.621895795679;6945.027696122547;6957.756478523227;5217.58259339252;5225.921611175835;5258.947410525846;5277.736113194325;5310.336207974004;4686;4733.053389322149;4751.453582838018;4775.6657034007985;4782.354382158364;5858.765649373977;5864.237649105589;5946.643201407843;5948.4943779779205;5982.371850955674;6623.536352455282;6814.182298124257;6828.146481689789;6833.624150671761;6919.584824910521;5843.649381037067;5850.9414905851245;5857.297124345106;5858.2677165354335;5867.970660146757;5830.329512106162;5841.766329346779;5850.882982340329;5858.677772722541;5861.501772349398;6661.1007513985;6695.866082678319;6741.224759152662;6747.527673062937;6751.696173672197;6880.483963702743;6888.931110689029;6890;6997.265287144776;6999.650017499206;6399.04014397844;6507.316731743099;6514.73941042353;6660.267370589135;6727.730890764315;6653.1018312527185;6656.5340426169705;6666.899996499959;6681.699323530355;6682.031105489774;6810.31896810315;6824.658767061726;6936.514443988873;6940.861182776417;6950.54821436605;6612.768553100618;6689.698963546554;6697.933020669731;6699.933000669931;6702.19573651165;6420.550561460653;6631.436327912182;6639.767608133692;6715.7985260442265;6716.865662686817;6406.23125224976;6434.8391290218115;6454.806355809334;6459.644719540471;6461.773837915651;6518.902216466851;6552.934470655423;6585.670716464253;6653;6722.394984451227;6435.613863168225;6445.774397896239;6509.544331896722;6527.5430719849155;6545.738170473128 01:13:48 INFO - PID 3781 | |1;ext.html;852.2117041736389;859.6776208921654;895.56565065943;898.9886377824947;905.0225756183322;40669.186616267696;41808.79095604525;41820.58179418205;41901;42038.159236815285;38324.80837595815;41373;42320.576794232045;42321;42452.78773606136;7630.809229769245;7658.3873290136935;7706.113796913371;7762.146163921992;7763.6506357213775;7660.923390766105;7752.883706744404;7775.028121484815;7786.8442631147345;7793.337566306871;7760;7822;7848.411369147337;7853.8036549086155;7864.646090925922;7764.767056988271;7770;7772.766816995528;7794.3764498839955;7794.649240784178;7434.405247580181;7540.509866858692;7540.8114797129965;7546.660400281946;7549.245075492462;38137;38205.617943820485;38739.225215495535;38758.61241387578;38764.224715505814;3498.4927185557954;3523.7533372663925;3528.858845646171;3532.293541291752;3535.2399234164523;31246.37507249865;31270.21824454384;31320.686793132234;31322.06033818966;31322.530162047588;5079.974600126976;5201.5838732901275;5228.398734145584;5270.4729527047375;5295.761690723888;193272;194275.0286248574;195031;195252;195568;47316.29025564619;47457.762711186224;47501.28748068782;47535;47616.285755713;49099.263511047364;49255;49360.50639493631;49423.75288123536;49517.257241141415;15983;16195.757063644054;16218.67562648764;16230.431934882223;16232;13245.867541324464;13302.467901284033;13308.134971227033;13317.467301308034;13323.533676321282;12905.35473226335;13364.131331463424;13375.197488150741;13400.597982060553;13508.392122354519;5228.63399562027;5255.684658920477;5259.552938000313;5310.7610157543;5316.441773613715;1003.3478239144614;1012.0031768707817;1022.1260821997234;1036.7978244242452;1056.8309070548676;22427.887860560593;22673;22917.656235156486;23128.190513331952;23222.071117155123;1126.2003977176296;1127.6278827986744;1133.206755271297;1139.128566646516;1150.3213104268523;12085.577004804789;12123.211991220542;12223.877761222451;12228.633141005785;12325.383730813424;233871;235484;235906;236968;237903;51102.23346649803;52048.479515204366;55622.72188639031;55794.163087553716;55807.72096139493;1423.3168079321983;1453.9563813085624;1474.5428917035754;1477.3204326010157;1481.5481278210034;26343.736562634127;26525;26673.06644267441;26762.732372676022;27007.86496067507;37201.81399092987;37400.62599373971;37418.251634967695;37427.625723742414;37448.251034979694;191632;192547;192785;192793;192928;33603.49594756032;33671.15822104467;33749.325013500085;34016.65983340135;34067.65932340645;40261.39607905942;40898.38652420275;41849;41879.371809423494;42040.36939445972;30483.2379190522;31466.52800207953;31536.842315788275;31663.20841978969;32543.837280813445;31226;31281.217969550944;31775.36449271048;31816.204594885312;31831.681683182873;34194.31611367709;34961.30077398488;35078.824605876805;35199;35239.82380088083;30548.389032218787;30727.539086913268;31085.911993080135;31095.844520777253;31164;23246;23399.649005264593;23441.41396465102;23458.76541234566;23476.765232347458 01:13:48 INFO - PID 3781 | |2;jquery.html;547.4634857839318;569.6212019007361;572.1560697970491;575.1372940589116;597.6981624279738;22373.216937407193;23117.422064448398;23176.999999999978;23185.420364490896;23302.3009309721;24268.39329016771;24622.630660540108;25040.248792536255;25451;25549.48901021983;6369.617822930627;6517.989711594711;6560.179977502812;6572.737090516373;6590.604563726168;6287.685615719196;6352.078948552457;6458.93427584448;6466.967665161667;6507.674616269192;6559.836004099888;6562.179727534059;6562.278149403585;6563.376479234489;6564.442022428076;6533.542652014361;6554.606723596576;6576.835579110512;6583.1441912551545;6588.604683718944;5795.3045634523705;6000.759969601254;6039.305479869783;6050.971334873038;6084.726187321581;29002.70997290021;29383.2654183645;29467.263318416997;29609.40781184386;29637.703622963927;1997.6703843865744;2005.7392538969987;2007.65869802134;2014.8488863335308;2019.8586098973078;19381.127849246677;19390.22439102434;19700.70448943267;19797.505062373413;20392.796072039386;2467.703875534947;2475.9752402475924;2528.190978886757;2528.494301139761;2529.9747002529925;125976.37011814975;132564.33717831445;132995;138813.99999999898;139485;20869.791302087087;21493.247736329155;21890.781092188874;22595.20916767905;22629.773702263097;41980.79009604932;42237;42425.57574424216;42473;42476;11167.218294719292;11326.716832079264;11385.544578216945;11598.76802463946;11624.6512604622;9534.856977145348;9541.3321067526;9543.809123817624;9593;9661.855072173923;11197.272177308449;11493.655190344303;11632.651020469399;11666.941665291619;11716.648500544827;4120.351859256321;4175.373693945871;4297.39836422901;4323.416338794285;4327.6321512671775;937.5687183895484;962.8651988721444;963.633819148733;966.1015255812022;974.1962880623514;19868.403947881587;20036.298729544396;20106.798932010784;20230.89884550568;20378.388648340573;1018.6689325968941;1034.6637342863598;1035.3735989726258;1036.18659352408;1049.21833234241;10758.892411075945;10874.510647020903;10950.616728414467;11083.168762342857;11119.11047116245;417491;417894;467699;477436;479044;113989.4300528492;114845;114903.42548287204;115472;116364;1149.6091328948198;1164.7321116143335;1166.2943918928927;1171.2094336323119;1173.02052785923;17618.647627047132;18009.459716208534;18103.81896181074;18113.36603218881;18264.908675456536;52351.47648523466;52475;53269;53328.20007699965;54273.18590221229;63850.361496384445;64962.67518662376;65469.672651636436;65476.67261663661;65799.67100164469;20163.495912602302;20316.695249570974;20461.69307460419;20682;20703.58592828105;22965.77034229703;23146.652800208347;23182.76817231806;23282.53434931258;23636.29091127269;18274.725879111556;18362.724559131355;18608.255669773058;18623;18858.717119243498;16624.667506650043;16633.667326653158;16657.66684666324;16987.40544080951;17284.56788580245;17629.20668569892;17717.84833985787;18748.81251187525;19176.90411547989;19278.036098195316;18231.544211394823;18477.81522184761;18554.907225463787;18625.53436164107;18819.341323053628;17296.82703172952;17803;17836.643267134845;18223.362182323555;18306.725399118757 01:13:48 INFO - PID 3781 | |3;mootools.html;1334.61296224095;1387.7987691784692;1397.043025527513;1401.3133564553373;1402.8597140285979;15032.323545440455;15646.530604081867;15759.448419305327;15772.526824195264;15776.842231577695;15343.539693809176;15378;15447.382104715825;15566.533004009869;15577;2742.9725702743017;2840.772738180951;2847.4162796626747;2849.3731379096566;2852;2618.829776064559;2731.740484653965;2778.597103420003;2783.1650504848567;2786.4427114577065;2771.459565384751;2815.366542527925;2816.070696670094;2816.7183931311206;2818.0700368878324;2488.6515887775727;2512.786413154866;2526.178991827654;2530;2534.2017264561605;2557.041109583906;2625.501154780605;2640.762331390184;2664.920052398412;2680;14539;14752.26238688072;14786.556403307917;14804;14810.851891481163;7879.684812607489;8127.268545830903;8153.959230203811;8155.877661835078;8172.6322315495945;5438.91841622376;5706.400827913051;5727.484526392603;5799.333076696192;5806.767729290823;1907.761529808774;1908.9713654295197;1915.8658893877296;1942.1939894943582;1954.5895361974003;26338.86830565835;26777.330566735793;26953.73046269532;27000;27068.864655676596;6949.374556289857;7073.92926070743;7187.676554555058;7312.670929808171;7360.153582337993;20055.29806456767;20060.197592096443;20061.191433199365;20083.19667213295;20084.297049603192;8087.959560202161;8242.876356854653;8252.422330436812;8318.168183181633;8322.916770832335;7201.567905925661;7262.745803896838;7351.44864135192;7394.963025184839;7426.702931882773;5562.082256427644;5723.170140329629;5781.103928891029;5799.623024503394;5809;1713.9828601713823;1740.3647668601122;1755.3943889358152;1770.150327842617;1778.4486809088964;879.3404946290283;893.7363477774072;896.9730908072638;898.8966268879032;914.1681070226063;7443.627818609048;7506.962465187639;7538.924610753932;7553;7571.848563028819;683.2654895986834;719.5502810743285;719.802054435024;720.8197950512372;727.3490226247479;4283.892902677396;4284.592963668447;4293.69944103916;5279.436594464539;5526.723663816873;20380.38858834237;20510.282140125026;20860.47848803792;21584;21593;20890.268840590506;21285;21435.356939291847;21440.892795536234;21457.78542214558;10280.177585793268;10312.02035806597;10434.426106564211;10589.682309530726;10647.733806654896;8111.513309201467;8414.4109912308;8485.490870547786;8485.618147183268;8500.404971651926;18013.819861801214;18031.81968180354;18436.723449148543;18575.53561160982;18838.52903677364;18858.24567017304;18858.339958101402;19123.426297211106;19259.22963081461;19497;12184.939075304566;12244.632661020183;12321.691957701129;12390.62828115158;12398.690032749253;13721.794173087212;14002.929985350009;14014.789778153132;14018;14021.29893505341;11289;11382.54469821231;11418.771624567627;11612.187146899636;11777.823332650189;10461.26771126014;10527.263091583516;10893.836592450962;10918.399488028235;10977.560897564008;10083.941186175345;10148.57919891201;10168.237382196217;10195.796084078425;10219.029192226726;7308.671109800178;7309;7365.926340736524;7367.889481657672;7426.814329641802;7161.785146445406;7177.246389129066;7273.763460211882;7293;7328.743493977685 01:13:48 INFO - PID 3781 | |4;prototype.html;499.3399813118304;503.94926578084716;521.6009752539308;529.6890196763014;530.411243519693;6134.944793494179;6213.596116252441;6263.060540918858;6283.780067697631;6365.936340636592;6122.510199184066;6132;6143.911070236119;6161.229846269216;6165.903592778454;4871.025794841028;4909.950900491003;4939.629527785412;4958.132326842806;4968.70187788732;4913.336699545552;4974.283872064132;4984.476629953857;5009.774560144802;5026.522480364378;4877.8780530486665;4885.413750349945;4890.14422476067;4933.161362568372;4937.80248790048;4927.162382394984;4933.161362568354;4934.111859865223;4974.303597496353;4988.700677959334;4453.487848897354;4457.799399027019;4464.330350447426;4474.105178964221;4494.438195225597;6031.909521357183;6072.878542429126;6093.086037094427;6097.3292937776805;6179.783707570258;5577.191307260465;5586.41342659019;5600.747966341524;5605.831825045255;5644.717764111778;6557.606543607351;6587.308332625101;6588.901166482507;6591.40677339037;6594.604323740591;4808.3989501312335;4815.374001379833;4822.300766388889;4828.299896514985;4853.635977301681;6843.8973415398805;6844.247132815436;6923.376896079327;6930.896036559456;6978.988046733246;4940.580050695731;4961.70229786214;4962.6774259673;4971.45314015458;4977.800887964513;4939.53074457926;5045.47022562633;5047.95557799092;5052.141136006888;5070.949290507121;5581.888362232733;5585.273914391103;5587.469190426984;5619.157126430986;5669.886602267931;6211.7388371105535;6329.303776584572;6380.9361906380345;6458.773942911976;6602;1700.396359292458;1701.4385252866525;1720.6816738903342;1722.9496898690518;1723.8967061080918;1199.8560172779323;1202.9939850300693;1205.8673545909942;1208.1274025260811;1221.4015132584968;5652.3217213934595;5702.51528620072;5801.7389217485315;5802.593818432753;5817.534597232211;6746.932530674729;6753.4751716350165;6792.490563207681;6799.354061364163;6815.807233734076;5804.593678442553;5804.970975145097;5809.302883653904;5847.181394604759;5867.882642347129;3546.858125674944;3581.265840502743;3594.6944509716445;3604.945925811115;3617.149969757105;6540.149780528501;6555.868882622321;6566.967165164144;6568.408843204134;6572.704228309737;6812.591244525344;6878.58728476293;6904.689288982008;6930.158634959643;6955.339242771928;6436.35636436362;6444.806655800334;6452.741890324334;6537.215534135839;6541.509386796104;6679.899801503078;6698.765543205965;6734.663266836541;6756.45948324123;6768.14215896934;6624.701888414937;6668.866622667617;6781.287485006037;6791.151106111736;6793.558418702769;6311.400416960381;6465.870682586228;6569.704363303567;6584.7036883341325;6605.47156227491;4871.293662419001;4902.975485122694;4910.361652985089;4931.926021109614;4944.456109827988;6782.320199062631;6783.321667833177;6798.694058767268;6804.931950680628;6831.282715315019;6485.3514648534765;6491.642959637265;6500.067459187124;6567.376099270562;6574.737010519717;6364.840878978062;6383.457406120346;6405.615663060231;6414.743410263537;6475.481961442979;6430.263828766113;6466.805995820133;6468.15913931186;6486.643234622141;6528.314526974599;6199.225096862892;6576.473882089517;6654.500912431684;6661.433778128913;6678.130123565409;6183.350748171557;6210.161628180319;6231.937680623136;6292.622442653455;6320.6839658016 01:13:48 INFO - PID 3781 | |5;yui.html;891.3760367742582;913.6847787513306;917.5045475443261;924.4684306523746;938.2494004796164;18510.90744546277;19239.71140432893;19302.90348548257;20862;22960.65559016612;20737.688934665955;20906.372808815722;21038.684419733716;21296.148154073857;21414.143434262613;960.394951180757;978.1783302026297;979.4661909259471;979.6130528441262;980.6469670918464;966.3718582921088;979.5151400056982;989.9802003959917;991.1476130527741;998.5057396588699;1046.3146638951462;1052.27393098762;1052.899974502421;1053.3048188195792;1053.7576357437795;1039.2153923787569;1039.4127318065307;1040.0587468341164;1040.6253748650518;1045.2526443592867;762.371043888794;767.1063211358816;768.7962689887185;772.7140957845577;772.8879312499656;20144.49638759043;20281.492962675904;20481.692774608393;20533.38399848007;20545;21656.675149872764;21725.67411488829;22379.776202238096;22384.32847014576;22399.776002240094;16857.91571042137;16968;17086.14569271544;17123.400680976105;17213.225404856687;3769.736118471708;3845.557760857509;3847.5575308839284;3867.961320386816;3868.883933481972;151298;151771;152770.23614881854;152838;154765;16578.83421165773;16752.41366552165;16864.747028794576;17060.57348566271;17098.0596067215;26955.865220674164;30662.233444163627;30695.539566906515;30699.38601227963;30729.078127656205;9114.680986165453;9248.537573121317;9278.628854845865;9303.53482325881;9320.95339523298;4384.276594361958;4448.110377924428;4474.060447306102;4476.552344765498;4482.843100491467;5279.155335146358;5351.25082488452;5400.243965844785;5411.080116380225;5445.891082178414;1138.0895283773114;1155.6764106050318;1161.6631176958756;1182.5624518928053;1186.2941549777868;686.2862622872157;712.8182313510022;713.1549114299571;718.4862823081418;735.9632018399059;12020.939895300642;12273.815892761615;12375.69060773488;13113.409896554678;13160.407781649848;708.242180866468;710.6979533698261;713.6931119618614;715.4348065028569;727.0620899040179;5727.3699893011735;5759.971200143972;5853.297604287428;5880.911786323209;5891.646501209942;124114;127928;128678.35660821636;128788;129103;108456.91543084469;109133.45433272782;109357.45321273502;110019.44990274997;113332.43333783279;98529.50735246278;100846.49576752217;101610.44363447392;101730.49134754279;104395;10797.892021079688;10803.45982700846;10898.836517452402;10905.672829815117;11171.72070698239;44378.77810610926;44822.3276650857;45060.07109538001;45597.088058239315;45793.313100304185;57041.71479142578;57213.42786572081;57498.70005199745;57932.42067579439;59298;15986.68026639484;16047.759283610989;16066.357345706041;16154.434594789125;16166.515004549883;18166.72749908726;18262.817371826113;18318;18438.446846594623;18504.907475462536;15804.76292855585;15912.681746365239;15922.60193495172;15965.600859978593;16084.758728619314;16891.91554042222;16920.830791692417;17107.657846842743;17176.22706978214;17449.214785334945;15170.393184272505;15434.768478472608;15502.84497155014;15604.92197539005;15613.84386156124;12013.219140755822;12239.20445171061;12266;12267.570635028089;12417.813732794197;12520.436580353724;12602.180858244184;12616.936915315364;12803.10378273512;12822.358882055672 01:13:48 INFO - PID 3781 | __end_tp_report 01:13:48 INFO - PID 3781 | __start_cc_report 01:13:48 INFO - PID 3781 | _x_x_mozilla_cycle_collect,352 01:13:48 INFO - PID 3781 | __end_cc_report 01:13:48 INFO - PID 3781 | __startTimestamp1505376828579__endTimestamp 01:13:48 INFO - PID 3781 | 01:13:48 INFO - PID 3781 | ------- Summary: start ------- 01:13:48 INFO - PID 3781 | Number of tests: 6 01:13:48 INFO - PID 3781 | 01:13:48 INFO - PID 3781 | [#0] dojo.html Cycles:165 Average:6264.38 Median:6476.48 stddev:756.42 (11.7%) stddev-sans-first:717.23 01:13:48 INFO - PID 3781 | Values: 3113.8 3158.4 3186.1 3198.4 3226.7 6238.8 6355.6 6394.0 6423.0 6486.4 6300.0 6350.9 6356.7 6362.7 6374.0 5796.9 5807.5 5812.3 5860.7 5930.9 5916.3 5920.1 5937.1 5960.1 5973.3 5757.0 5835.5 5912.1 5929.6 5950.8 5641.1 5670.5 5773.8 5848.5 5881.5 5766.8 5800.6 5840.1 5842.9 5900.0 6161.8 6233.6 6273.1 6350.9 6449.0 6645.1 6681.1 6684.6 6725.5 6819.9 6901.8 6959.3 6977.1 6984.2 6993.9 6373.4 6381.0 6456.6 6468.9 6476.5 6852.7 6939.3 6939.5 6945.4 6951.9 6539.2 6603.9 6623.9 6625.1 6638.9 6722.5 6797.5 6933.4 6953.3 6953.5 6800.8 6806.6 6892.0 6901.4 6903.1 6601.4 6863.9 6874.6 6945.0 6957.8 5217.6 5225.9 5258.9 5277.7 5310.3 4686.0 4733.1 4751.5 4775.7 4782.4 5858.8 5864.2 5946.6 5948.5 5982.4 6623.5 6814.2 6828.1 6833.6 6919.6 5843.6 5850.9 5857.3 5858.3 5868.0 5830.3 5841.8 5850.9 5858.7 5861.5 6661.1 6695.9 6741.2 6747.5 6751.7 6880.5 6888.9 6890.0 6997.3 6999.7 6399.0 6507.3 6514.7 6660.3 6727.7 6653.1 6656.5 6666.9 6681.7 6682.0 6810.3 6824.7 6936.5 6940.9 6950.5 6612.8 6689.7 6697.9 6699.9 6702.2 6420.6 6631.4 6639.8 6715.8 6716.9 6406.2 6434.8 6454.8 6459.6 6461.8 6518.9 6552.9 6585.7 6653.0 6722.4 6435.6 6445.8 6509.5 6527.5 6545.7 01:13:48 INFO - PID 3781 | 01:13:48 INFO - PID 3781 | [#1] ext.html Cycles:180 Average:37598.81 Median:34577.81 stddev:54068.80 (156.4%) stddev-sans-first:54150.07 01:13:48 INFO - PID 3781 | Values: 852.2 859.7 895.6 899.0 905.0 40669.2 41808.8 41820.6 41901.0 42038.2 38324.8 41373.0 42320.6 42321.0 42452.8 7630.8 7658.4 7706.1 7762.1 7763.7 7660.9 7752.9 7775.0 7786.8 7793.3 7760.0 7822.0 7848.4 7853.8 7864.6 7764.8 7770.0 7772.8 7794.4 7794.6 7434.4 7540.5 7540.8 7546.7 7549.2 38137.0 38205.6 38739.2 38758.6 38764.2 3498.5 3523.8 3528.9 3532.3 3535.2 31246.4 31270.2 31320.7 31322.1 31322.5 5080.0 5201.6 5228.4 5270.5 5295.8 193272.0 194275.0 195031.0 195252.0 195568.0 47316.3 47457.8 47501.3 47535.0 47616.3 49099.3 49255.0 49360.5 49423.8 49517.3 15983.0 16195.8 16218.7 16230.4 16232.0 13245.9 13302.5 13308.1 13317.5 13323.5 12905.4 13364.1 13375.2 13400.6 13508.4 5228.6 5255.7 5259.6 5310.8 5316.4 1003.3 1012.0 1022.1 1036.8 1056.8 22427.9 22673.0 22917.7 23128.2 23222.1 1126.2 1127.6 1133.2 1139.1 1150.3 12085.6 12123.2 12223.9 12228.6 12325.4 233871.0 235484.0 235906.0 236968.0 237903.0 51102.2 52048.5 55622.7 55794.2 55807.7 1423.3 1454.0 1474.5 1477.3 1481.5 26343.7 26525.0 26673.1 26762.7 27007.9 37201.8 37400.6 37418.3 37427.6 37448.3 191632.0 192547.0 192785.0 192793.0 192928.0 33603.5 33671.2 33749.3 34016.7 34067.7 40261.4 40898.4 41849.0 41879.4 42040.4 30483.2 31466.5 31536.8 31663.2 32543.8 31226.0 31281.2 31775.4 31816.2 31831.7 34194.3 34961.3 35078.8 35199.0 35239.8 30548.4 30727.5 31085.9 31095.8 31164.0 23246.0 23399.6 23441.4 23458.8 23476.8 01:13:48 INFO - PID 3781 | 01:13:48 INFO - PID 3781 | [#2] jquery.html Cycles:180 Average:34468.47 Median:22797.77 stddev:76453.51 (335.4%) stddev-sans-first:76625.56 01:13:48 INFO - PID 3781 | Values: 547.5 569.6 572.2 575.1 597.7 22373.2 23117.4 23177.0 23185.4 23302.3 24268.4 24622.6 25040.2 25451.0 25549.5 6369.6 6518.0 6560.2 6572.7 6590.6 6287.7 6352.1 6458.9 6467.0 6507.7 6559.8 6562.2 6562.3 6563.4 6564.4 6533.5 6554.6 6576.8 6583.1 6588.6 5795.3 6000.8 6039.3 6051.0 6084.7 29002.7 29383.3 29467.3 29609.4 29637.7 1997.7 2005.7 2007.7 2014.8 2019.9 19381.1 19390.2 19700.7 19797.5 20392.8 2467.7 2476.0 2528.2 2528.5 2530.0 125976.4 132564.3 132995.0 138814.0 139485.0 20869.8 21493.2 21890.8 22595.2 22629.8 41980.8 42237.0 42425.6 42473.0 42476.0 11167.2 11326.7 11385.5 11598.8 11624.7 9534.9 9541.3 9543.8 9593.0 9661.9 11197.3 11493.7 11632.7 11666.9 11716.6 4120.4 4175.4 4297.4 4323.4 4327.6 937.6 962.9 963.6 966.1 974.2 19868.4 20036.3 20106.8 20230.9 20378.4 1018.7 1034.7 1035.4 1036.2 1049.2 10758.9 10874.5 10950.6 11083.2 11119.1 417491.0 417894.0 467699.0 477436.0 479044.0 113989.4 114845.0 114903.4 115472.0 116364.0 1149.6 1164.7 1166.3 1171.2 1173.0 17618.6 18009.5 18103.8 18113.4 18264.9 52351.5 52475.0 53269.0 53328.2 54273.2 63850.4 64962.7 65469.7 65476.7 65799.7 20163.5 20316.7 20461.7 20682.0 20703.6 22965.8 23146.7 23182.8 23282.5 23636.3 18274.7 18362.7 18608.3 18623.0 18858.7 16624.7 16633.7 16657.7 16987.4 17284.6 17629.2 17717.8 18748.8 19176.9 19278.0 18231.5 18477.8 18554.9 18625.5 18819.3 17296.8 17803.0 17836.6 18223.4 18306.7 01:13:48 INFO - PID 3781 | 01:13:48 INFO - PID 3781 | [#3] mootools.html Cycles:180 Average:9426.33 Median:2587.94 stddev:6759.11 (261.2%) stddev-sans-first:6750.73 01:13:48 INFO - PID 3781 | Values: 1334.6 1387.8 1397.0 1401.3 1402.9 15032.3 15646.5 15759.4 15772.5 15776.8 15343.5 15378.0 15447.4 15566.5 15577.0 2743.0 2840.8 2847.4 2849.4 2852.0 2618.8 2731.7 2778.6 2783.2 2786.4 2771.5 2815.4 2816.1 2816.7 2818.1 2488.7 2512.8 2526.2 2530.0 2534.2 2557.0 2625.5 2640.8 2664.9 2680.0 14539.0 14752.3 14786.6 14804.0 14810.9 7879.7 8127.3 8154.0 8155.9 8172.6 5438.9 5706.4 5727.5 5799.3 5806.8 1907.8 1909.0 1915.9 1942.2 1954.6 26338.9 26777.3 26953.7 27000.0 27068.9 6949.4 7073.9 7187.7 7312.7 7360.2 20055.3 20060.2 20061.2 20083.2 20084.3 8088.0 8242.9 8252.4 8318.2 8322.9 7201.6 7262.7 7351.4 7395.0 7426.7 5562.1 5723.2 5781.1 5799.6 5809.0 1714.0 1740.4 1755.4 1770.2 1778.4 879.3 893.7 897.0 898.9 914.2 7443.6 7507.0 7538.9 7553.0 7571.8 683.3 719.6 719.8 720.8 727.3 4283.9 4284.6 4293.7 5279.4 5526.7 20380.4 20510.3 20860.5 21584.0 21593.0 20890.3 21285.0 21435.4 21440.9 21457.8 10280.2 10312.0 10434.4 10589.7 10647.7 8111.5 8414.4 8485.5 8485.6 8500.4 18013.8 18031.8 18436.7 18575.5 18838.5 18858.2 18858.3 19123.4 19259.2 19497.0 12184.9 12244.6 12321.7 12390.6 12398.7 13721.8 14002.9 14014.8 14018.0 14021.3 11289.0 11382.5 11418.8 11612.2 11777.8 10461.3 10527.3 10893.8 10918.4 10977.6 10083.9 10148.6 10168.2 10195.8 10219.0 7308.7 7309.0 7365.9 7367.9 7426.8 7161.8 7177.2 7273.8 7293.0 7328.7 01:13:48 INFO - PID 3781 | 01:13:48 INFO - PID 3781 | [#4] prototype.html Cycles:180 Average:5496.26 Median:6133.47 stddev:1553.15 (25.3%) stddev-sans-first:1511.54 01:13:48 INFO - PID 3781 | Values: 499.3 503.9 521.6 529.7 530.4 6134.9 6213.6 6263.1 6283.8 6365.9 6122.5 6132.0 6143.9 6161.2 6165.9 4871.0 4910.0 4939.6 4958.1 4968.7 4913.3 4974.3 4984.5 5009.8 5026.5 4877.9 4885.4 4890.1 4933.2 4937.8 4927.2 4933.2 4934.1 4974.3 4988.7 4453.5 4457.8 4464.3 4474.1 4494.4 6031.9 6072.9 6093.1 6097.3 6179.8 5577.2 5586.4 5600.7 5605.8 5644.7 6557.6 6587.3 6588.9 6591.4 6594.6 4808.4 4815.4 4822.3 4828.3 4853.6 6843.9 6844.2 6923.4 6930.9 6979.0 4940.6 4961.7 4962.7 4971.5 4977.8 4939.5 5045.5 5048.0 5052.1 5070.9 5581.9 5585.3 5587.5 5619.2 5669.9 6211.7 6329.3 6380.9 6458.8 6602.0 1700.4 1701.4 1720.7 1722.9 1723.9 1199.9 1203.0 1205.9 1208.1 1221.4 5652.3 5702.5 5801.7 5802.6 5817.5 6746.9 6753.5 6792.5 6799.4 6815.8 5804.6 5805.0 5809.3 5847.2 5867.9 3546.9 3581.3 3594.7 3604.9 3617.1 6540.1 6555.9 6567.0 6568.4 6572.7 6812.6 6878.6 6904.7 6930.2 6955.3 6436.4 6444.8 6452.7 6537.2 6541.5 6679.9 6698.8 6734.7 6756.5 6768.1 6624.7 6668.9 6781.3 6791.2 6793.6 6311.4 6465.9 6569.7 6584.7 6605.5 4871.3 4903.0 4910.4 4931.9 4944.5 6782.3 6783.3 6798.7 6804.9 6831.3 6485.4 6491.6 6500.1 6567.4 6574.7 6364.8 6383.5 6405.6 6414.7 6475.5 6430.3 6466.8 6468.2 6486.6 6528.3 6199.2 6576.5 6654.5 6661.4 6678.1 6183.4 6210.2 6231.9 6292.6 6320.7 01:13:48 INFO - PID 3781 | 01:13:48 INFO - PID 3781 | [#5] yui.html Cycles:180 Average:25302.27 Median:19271.31 stddev:37282.80 (193.5%) stddev-sans-first:37342.33 01:13:48 INFO - PID 3781 | Values: 891.4 913.7 917.5 924.5 938.2 18510.9 19239.7 19302.9 20862.0 22960.7 20737.7 20906.4 21038.7 21296.1 21414.1 960.4 978.2 979.5 979.6 980.6 966.4 979.5 990.0 991.1 998.5 1046.3 1052.3 1052.9 1053.3 1053.8 1039.2 1039.4 1040.1 1040.6 1045.3 762.4 767.1 768.8 772.7 772.9 20144.5 20281.5 20481.7 20533.4 20545.0 21656.7 21725.7 22379.8 22384.3 22399.8 16857.9 16968.0 17086.1 17123.4 17213.2 3769.7 3845.6 3847.6 3868.0 3868.9 151298.0 151771.0 152770.2 152838.0 154765.0 16578.8 16752.4 16864.7 17060.6 17098.1 26955.9 30662.2 30695.5 30699.4 30729.1 9114.7 9248.5 9278.6 9303.5 9321.0 4384.3 4448.1 4474.1 4476.6 4482.8 5279.2 5351.3 5400.2 5411.1 5445.9 1138.1 1155.7 1161.7 1182.6 1186.3 686.3 712.8 713.2 718.5 736.0 12020.9 12273.8 12375.7 13113.4 13160.4 708.2 710.7 713.7 715.4 727.1 5727.4 5760.0 5853.3 5880.9 5891.6 124114.0 127928.0 128678.4 128788.0 129103.0 108456.9 109133.5 109357.5 110019.4 113332.4 98529.5 100846.5 101610.4 101730.5 104395.0 10797.9 10803.5 10898.8 10905.7 11171.7 44378.8 44822.3 45060.1 45597.1 45793.3 57041.7 57213.4 57498.7 57932.4 59298.0 15986.7 16047.8 16066.4 16154.4 16166.5 18166.7 18262.8 18318.0 18438.4 18504.9 15804.8 15912.7 15922.6 15965.6 16084.8 16891.9 16920.8 17107.7 17176.2 17449.2 15170.4 15434.8 15502.8 15604.9 15613.8 12013.2 12239.2 12266.0 12267.6 12417.8 12520.4 12602.2 12616.9 12803.1 12822.4 01:13:48 INFO - PID 3781 | -------- Summary: end -------- 01:13:48 INFO - PID 3781 | 01:13:49 INFO - TEST-INFO | 3781: exit 0 01:13:49 INFO - TEST-OK | dromaeo_css | took 1111748ms 01:13:49 INFO - TEST-START | kraken 01:13:49 INFO - Initialising browser for kraken test... 01:13:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50632/getInfo.html -profile /tmp/tmptYQbnm/profile 01:13:49 INFO - TEST-INFO | started process 4146 (/builds/slave/test/build/application/firefox/firefox http://localhost:50632/getInfo.html) 01:13:54 INFO - TEST-INFO | 4146: exit 0 01:13:54 INFO - Browser initialized. 01:13:54 INFO - Running cycle 1/1 for kraken test... 01:13:54 INFO - Using env: {'DISPLAY': ':0', 01:13:54 INFO - 'HOME': '/home/cltbld', 01:13:54 INFO - 'JSGC_DISABLE_POISONING': '1', 01:13:54 INFO - 'LANG': 'en_US.UTF-8', 01:13:54 INFO - 'LANGUAGE': 'en_US:en', 01:13:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 01:13:54 INFO - 'LOGNAME': 'cltbld', 01:13:54 INFO - 'MAIL': '/var/mail/cltbld', 01:13:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:13:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:13:54 INFO - 'MOZ_CRASHREPORTER': '1', 01:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 01:13:54 INFO - 'MOZ_NO_REMOTE': '1', 01:13:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:13:54 INFO - 'NO_EM_RESTART': '1', 01:13:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:54 INFO - 'PWD': '/builds/slave/test', 01:13:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:13:54 INFO - 'RUST_BACKTRACE': 'full', 01:13:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 01:13:54 INFO - 'SHELL': '/bin/bash', 01:13:54 INFO - 'SHLVL': '1', 01:13:54 INFO - 'STYLO_FORCE_DISABLED': '1', 01:13:54 INFO - 'TERM': 'linux', 01:13:54 INFO - 'TMOUT': '86400', 01:13:54 INFO - 'USER': 'cltbld', 01:13:54 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327', 01:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:54 INFO - '_': '/tools/buildbot/bin/python'} 01:13:54 INFO - TEST-INFO | started process 4378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptYQbnm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 01:13:55 INFO - PID 4378 | 01:13:55 INFO - PID 4378 | (/builds/slave/test/build/application/firefox/firefox:4427): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 01:13:55 INFO - PID 4378 | 01:14:06 INFO - PID 4378 | RSS: Main: 173027328 01:14:06 INFO - PID 4378 | 01:14:08 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:50632/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50632/tests/kraken/driver.html?testName=audio-beat-detection) 01:14:09 INFO - PID 4378 | RSS: Main: 177971200 01:14:09 INFO - PID 4378 | 01:14:12 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:50632/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50632/tests/kraken/driver.html?testName=audio-dft) 01:14:13 INFO - PID 4378 | RSS: Main: 178241536 01:14:13 INFO - PID 4378 | 01:14:16 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:50632/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50632/tests/kraken/driver.html?testName=audio-fft) 01:14:16 INFO - PID 4378 | RSS: Main: 174022656 01:14:16 INFO - PID 4378 | 01:14:18 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:50632/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50632/tests/kraken/driver.html?testName=audio-oscillator) 01:14:19 INFO - PID 4378 | RSS: Main: 174923776 01:14:19 INFO - PID 4378 | 01:14:21 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:50632/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50632/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:14:22 INFO - PID 4378 | RSS: Main: 175243264 01:14:22 INFO - PID 4378 | 01:14:25 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:50632/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50632/tests/kraken/driver.html?testName=imaging-darkroom) 01:14:26 INFO - PID 4378 | RSS: Main: 177524736 01:14:26 INFO - PID 4378 | 01:14:29 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:50632/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50632/tests/kraken/driver.html?testName=imaging-desaturate) 01:14:30 INFO - PID 4378 | RSS: Main: 177770496 01:14:30 INFO - PID 4378 | 01:14:33 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:50632/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50632/tests/kraken/driver.html?testName=json-parse-financial) 01:14:34 INFO - PID 4378 | RSS: Main: 177070080 01:14:34 INFO - PID 4378 | 01:14:35 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:50632/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50632/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:14:36 INFO - PID 4378 | RSS: Main: 177590272 01:14:36 INFO - PID 4378 | 01:14:37 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:50632/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50632/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:14:38 INFO - PID 4378 | RSS: Main: 177700864 01:14:38 INFO - PID 4378 | 01:14:40 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:50632/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50632/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:14:41 INFO - PID 4378 | RSS: Main: 174628864 01:14:41 INFO - PID 4378 | 01:14:43 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:50632/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50632/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:14:44 INFO - PID 4378 | RSS: Main: 174809088 01:14:44 INFO - PID 4378 | 01:14:47 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:50632/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50632/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:14:48 INFO - PID 4378 | RSS: Main: 175169536 01:14:48 INFO - PID 4378 | 01:14:49 INFO - PID 4378 | Cycle 1(1): loaded http://localhost:50632/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50632/tests/kraken/driver.html?testName=ai-astar) 01:14:50 INFO - PID 4378 | RSS: Main: 176340992 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | __start_tp_report 01:14:50 INFO - PID 4378 | _x_x_mozilla_page_load 01:14:50 INFO - PID 4378 | _x_x_mozilla_page_load_details 01:14:50 INFO - PID 4378 | |i|pagename|runs| 01:14:50 INFO - PID 4378 | |0;ai-astar;111;108;107;109;109;111;108;110;108;107 01:14:50 INFO - PID 4378 | |1;audio-beat-detection;115;116;120;120;120;116;150;118;116;121 01:14:50 INFO - PID 4378 | |2;audio-dft;162;161;162;162;164;163;167;167;162;167 01:14:50 INFO - PID 4378 | |3;audio-fft;73;74;74;84;75;75;74;74;74;74 01:14:50 INFO - PID 4378 | |4;audio-oscillator;79;80;82;84;78;78;78;79;78;79 01:14:50 INFO - PID 4378 | |5;imaging-gaussian-blur;110;113;114;114;115;114;114;120;113;119 01:14:50 INFO - PID 4378 | |6;imaging-darkroom;152;148;148;147;149;149;150;148;148;148 01:14:50 INFO - PID 4378 | |7;imaging-desaturate;94;94;94;94;95;94;94;95;94;94 01:14:50 INFO - PID 4378 | |8;json-parse-financial;54;54;56;56;54;55;54;54;54;54 01:14:50 INFO - PID 4378 | |9;json-stringify-tinderbox;38;37;38;38;38;38;38;38;38;37 01:14:50 INFO - PID 4378 | |10;stanford-crypto-aes;73;74;73;73;76;74;73;78;73;74 01:14:50 INFO - PID 4378 | |11;stanford-crypto-ccm;113;113;115;116;113;121;114;116;116;113 01:14:50 INFO - PID 4378 | |12;stanford-crypto-pbkdf2;171;172;168;166;171;173;169;177;168;171 01:14:50 INFO - PID 4378 | |13;stanford-crypto-sha256-iterative;70;65;66;72;66;65;65;68;67;76 01:14:50 INFO - PID 4378 | __end_tp_report 01:14:50 INFO - PID 4378 | __start_cc_report 01:14:50 INFO - PID 4378 | _x_x_mozilla_cycle_collect,938 01:14:50 INFO - PID 4378 | __end_cc_report 01:14:50 INFO - PID 4378 | __startTimestamp1505376890160__endTimestamp 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | ------- Summary: start ------- 01:14:50 INFO - PID 4378 | Number of tests: 14 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.00 stddev:1.48 (1.4%) stddev-sans-first:1.33 01:14:50 INFO - PID 4378 | Values: 111.0 108.0 107.0 109.0 109.0 111.0 108.0 110.0 108.0 107.0 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | [#1] audio-beat-detection Cycles:10 Average:121.20 Median:120.00 stddev:10.35 (8.6%) stddev-sans-first:10.73 01:14:50 INFO - PID 4378 | Values: 115.0 116.0 120.0 120.0 120.0 116.0 150.0 118.0 116.0 121.0 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.41 (1.5%) stddev-sans-first:2.47 01:14:50 INFO - PID 4378 | Values: 162.0 161.0 162.0 162.0 164.0 163.0 167.0 167.0 162.0 167.0 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | [#3] audio-fft Cycles:10 Average:75.10 Median:74.00 stddev:3.18 (4.3%) stddev-sans-first:3.28 01:14:50 INFO - PID 4378 | Values: 73.0 74.0 74.0 84.0 75.0 75.0 74.0 74.0 74.0 74.0 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:79.00 stddev:2.01 (2.5%) stddev-sans-first:2.13 01:14:50 INFO - PID 4378 | Values: 79.0 80.0 82.0 84.0 78.0 78.0 78.0 79.0 78.0 79.0 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.00 stddev:2.91 (2.6%) stddev-sans-first:2.57 01:14:50 INFO - PID 4378 | Values: 110.0 113.0 114.0 114.0 115.0 114.0 114.0 120.0 113.0 119.0 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.50 stddev:1.42 (1.0%) stddev-sans-first:0.87 01:14:50 INFO - PID 4378 | Values: 152.0 148.0 148.0 147.0 149.0 149.0 150.0 148.0 148.0 148.0 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:14:50 INFO - PID 4378 | Values: 94.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:0.85 (1.6%) stddev-sans-first:0.88 01:14:50 INFO - PID 4378 | Values: 54.0 54.0 56.0 56.0 54.0 55.0 54.0 54.0 54.0 54.0 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 01:14:50 INFO - PID 4378 | Values: 38.0 37.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 37.0 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:74.00 stddev:1.66 (2.2%) stddev-sans-first:1.72 01:14:50 INFO - PID 4378 | Values: 73.0 74.0 73.0 73.0 76.0 74.0 73.0 78.0 73.0 74.0 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | [#11] stanford-crypto-ccm Cycles:10 Average:115.00 Median:115.50 stddev:2.49 (2.2%) stddev-sans-first:2.54 01:14:50 INFO - PID 4378 | Values: 113.0 113.0 115.0 116.0 113.0 121.0 114.0 116.0 116.0 113.0 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:171.00 stddev:3.10 (1.8%) stddev-sans-first:3.28 01:14:50 INFO - PID 4378 | Values: 171.0 172.0 168.0 166.0 171.0 173.0 169.0 177.0 168.0 171.0 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:67.50 stddev:3.65 (5.4%) stddev-sans-first:3.80 01:14:50 INFO - PID 4378 | Values: 70.0 65.0 66.0 72.0 66.0 65.0 65.0 68.0 67.0 76.0 01:14:50 INFO - PID 4378 | -------- Summary: end -------- 01:14:50 INFO - PID 4378 | 01:14:50 INFO - PID 4378 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 01:14:50 INFO - TEST-INFO | 4378: exit 0 01:14:50 INFO - TEST-OK | kraken | took 61651ms 01:14:50 INFO - SUITE-END | took 1173s 01:14:51 INFO - Completed test suite (00:19:33) 01:14:51 INFO - javascript benchmark 01:14:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8653.566811488154, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.844307784611, 3158.4156930967756, 3186.1238159506124, 3198.424283628946, 3226.709596136349, 6238.812835614927, 6355.586886852351, 6394.008928616066, 6422.967885160573, 6486.416222539976, 6300.0, 6350.904736428957, 6356.713947872346, 6362.650054247015, 6374.04389341599, 5796.855078623026, 5807.535397168216, 5812.331581868087, 5860.736266868002, 5930.940690593104, 5916.2900451945825, 5920.141579470974, 5937.109433584975, 5960.135780311853, 5973.253343332083, 5756.971215143918, 5835.533275986517, 5912.113183022538, 5929.584929054968, 5950.761969521214, 5641.125625528009, 5670.461306175906, 5773.769049238025, 5848.5321174305955, 5881.529477641779, 5766.769329226826, 5800.622959507661, 5840.065589505702, 5842.912356314659, 5900.026495628216, 6161.784337548164, 6233.625982441068, 6273.0904018917, 6350.904736428957, 6448.967755161194, 6645.1361323027695, 6681.098051762999, 6684.632345221011, 6725.461963042993, 6819.931800681979, 6901.827454313632, 6959.269276725921, 6977.1278590176225, 6984.196817365966, 6993.930060699429, 6373.42639162473, 6381.042843573455, 6456.612603243821, 6468.902966455507, 6476.481881449426, 6852.6916288767125, 6939.30606939302, 6939.514234003571, 6945.374916257561, 6951.89572156418, 6539.2479864815205, 6603.867922641521, 6623.9006414903815, 6625.105610742585, 6638.86722265552, 6722.495812814059, 6797.524173307821, 6933.375996160269, 6953.304669533108, 6953.548019378724, 6800.795976120724, 6806.625635589991, 6891.965540172267, 6901.378875901193, 6903.1371078615175, 6601.3728695773825, 6863.862722745517, 6874.621895795679, 6945.027696122547, 6957.756478523227, 5217.58259339252, 5225.921611175835, 5258.947410525846, 5277.736113194325, 5310.336207974004, 4686.0, 4733.053389322149, 4751.453582838018, 4775.6657034007985, 4782.354382158364, 5858.765649373977, 5864.237649105589, 5946.643201407843, 5948.4943779779205, 5982.371850955674, 6623.536352455282, 6814.182298124257, 6828.146481689789, 6833.624150671761, 6919.584824910521, 5843.649381037067, 5850.9414905851245, 5857.297124345106, 5858.2677165354335, 5867.970660146757, 5830.329512106162, 5841.766329346779, 5850.882982340329, 5858.677772722541, 5861.501772349398, 6661.1007513985, 6695.866082678319, 6741.224759152662, 6747.527673062937, 6751.696173672197, 6880.483963702743, 6888.931110689029, 6890.0, 6997.265287144776, 6999.650017499206, 6399.04014397844, 6507.316731743099, 6514.73941042353, 6660.267370589135, 6727.730890764315, 6653.1018312527185, 6656.5340426169705, 6666.899996499959, 6681.699323530355, 6682.031105489774, 6810.31896810315, 6824.658767061726, 6936.514443988873, 6940.861182776417, 6950.54821436605, 6612.768553100618, 6689.698963546554, 6697.933020669731, 6699.933000669931, 6702.19573651165, 6420.550561460653, 6631.436327912182, 6639.767608133692, 6715.7985260442265, 6716.865662686817, 6406.23125224976, 6434.8391290218115, 6454.806355809334, 6459.644719540471, 6461.773837915651, 6518.902216466851, 6552.934470655423, 6585.670716464253, 6653.0, 6722.394984451227, 6435.613863168225, 6445.774397896239, 6509.544331896722, 6527.5430719849155, 6545.738170473128], "value": 6206.355246854662, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [852.2117041736389, 859.6776208921654, 895.56565065943, 898.9886377824947, 905.0225756183322, 40669.186616267696, 41808.79095604525, 41820.58179418205, 41901.0, 42038.159236815285, 38324.80837595815, 41373.0, 42320.576794232045, 42321.0, 42452.78773606136, 7630.809229769245, 7658.3873290136935, 7706.113796913371, 7762.146163921992, 7763.6506357213775, 7660.923390766105, 7752.883706744404, 7775.028121484815, 7786.8442631147345, 7793.337566306871, 7760.0, 7822.0, 7848.411369147337, 7853.8036549086155, 7864.646090925922, 7764.767056988271, 7770.0, 7772.766816995528, 7794.3764498839955, 7794.649240784178, 7434.405247580181, 7540.509866858692, 7540.8114797129965, 7546.660400281946, 7549.245075492462, 38137.0, 38205.617943820485, 38739.225215495535, 38758.61241387578, 38764.224715505814, 3498.4927185557954, 3523.7533372663925, 3528.858845646171, 3532.293541291752, 3535.2399234164523, 31246.37507249865, 31270.21824454384, 31320.686793132234, 31322.06033818966, 31322.530162047588, 5079.974600126976, 5201.5838732901275, 5228.398734145584, 5270.4729527047375, 5295.761690723888, 193272.0, 194275.0286248574, 195031.0, 195252.0, 195568.0, 47316.29025564619, 47457.762711186224, 47501.28748068782, 47535.0, 47616.285755713, 49099.263511047364, 49255.0, 49360.50639493631, 49423.75288123536, 49517.257241141415, 15983.0, 16195.757063644054, 16218.67562648764, 16230.431934882223, 16232.0, 13245.867541324464, 13302.467901284033, 13308.134971227033, 13317.467301308034, 13323.533676321282, 12905.35473226335, 13364.131331463424, 13375.197488150741, 13400.597982060553, 13508.392122354519, 5228.63399562027, 5255.684658920477, 5259.552938000313, 5310.7610157543, 5316.441773613715, 1003.3478239144614, 1012.0031768707817, 1022.1260821997234, 1036.7978244242452, 1056.8309070548676, 22427.887860560593, 22673.0, 22917.656235156486, 23128.190513331952, 23222.071117155123, 1126.2003977176296, 1127.6278827986744, 1133.206755271297, 1139.128566646516, 1150.3213104268523, 12085.577004804789, 12123.211991220542, 12223.877761222451, 12228.633141005785, 12325.383730813424, 233871.0, 235484.0, 235906.0, 236968.0, 237903.0, 51102.23346649803, 52048.479515204366, 55622.72188639031, 55794.163087553716, 55807.72096139493, 1423.3168079321983, 1453.9563813085624, 1474.5428917035754, 1477.3204326010157, 1481.5481278210034, 26343.736562634127, 26525.0, 26673.06644267441, 26762.732372676022, 27007.86496067507, 37201.81399092987, 37400.62599373971, 37418.251634967695, 37427.625723742414, 37448.251034979694, 191632.0, 192547.0, 192785.0, 192793.0, 192928.0, 33603.49594756032, 33671.15822104467, 33749.325013500085, 34016.65983340135, 34067.65932340645, 40261.39607905942, 40898.38652420275, 41849.0, 41879.371809423494, 42040.36939445972, 30483.2379190522, 31466.52800207953, 31536.842315788275, 31663.20841978969, 32543.837280813445, 31226.0, 31281.217969550944, 31775.36449271048, 31816.204594885312, 31831.681683182873, 34194.31611367709, 34961.30077398488, 35078.824605876805, 35199.0, 35239.82380088083, 30548.389032218787, 30727.539086913268, 31085.911993080135, 31095.844520777253, 31164.0, 23246.0, 23399.649005264593, 23441.41396465102, 23458.76541234566, 23476.765232347458], "value": 17132.193013069482, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.4634857839318, 569.6212019007361, 572.1560697970491, 575.1372940589116, 597.6981624279738, 22373.216937407193, 23117.422064448398, 23176.999999999978, 23185.420364490896, 23302.3009309721, 24268.39329016771, 24622.630660540108, 25040.248792536255, 25451.0, 25549.48901021983, 6369.617822930627, 6517.989711594711, 6560.179977502812, 6572.737090516373, 6590.604563726168, 6287.685615719196, 6352.078948552457, 6458.93427584448, 6466.967665161667, 6507.674616269192, 6559.836004099888, 6562.179727534059, 6562.278149403585, 6563.376479234489, 6564.442022428076, 6533.542652014361, 6554.606723596576, 6576.835579110512, 6583.1441912551545, 6588.604683718944, 5795.3045634523705, 6000.759969601254, 6039.305479869783, 6050.971334873038, 6084.726187321581, 29002.70997290021, 29383.2654183645, 29467.263318416997, 29609.40781184386, 29637.703622963927, 1997.6703843865744, 2005.7392538969987, 2007.65869802134, 2014.8488863335308, 2019.8586098973078, 19381.127849246677, 19390.22439102434, 19700.70448943267, 19797.505062373413, 20392.796072039386, 2467.703875534947, 2475.9752402475924, 2528.190978886757, 2528.494301139761, 2529.9747002529925, 125976.37011814975, 132564.33717831445, 132995.0, 138813.99999999898, 139485.0, 20869.791302087087, 21493.247736329155, 21890.781092188874, 22595.20916767905, 22629.773702263097, 41980.79009604932, 42237.0, 42425.57574424216, 42473.0, 42476.0, 11167.218294719292, 11326.716832079264, 11385.544578216945, 11598.76802463946, 11624.6512604622, 9534.856977145348, 9541.3321067526, 9543.809123817624, 9593.0, 9661.855072173923, 11197.272177308449, 11493.655190344303, 11632.651020469399, 11666.941665291619, 11716.648500544827, 4120.351859256321, 4175.373693945871, 4297.39836422901, 4323.416338794285, 4327.6321512671775, 937.5687183895484, 962.8651988721444, 963.633819148733, 966.1015255812022, 974.1962880623514, 19868.403947881587, 20036.298729544396, 20106.798932010784, 20230.89884550568, 20378.388648340573, 1018.6689325968941, 1034.6637342863598, 1035.3735989726258, 1036.18659352408, 1049.21833234241, 10758.892411075945, 10874.510647020903, 10950.616728414467, 11083.168762342857, 11119.11047116245, 417491.0, 417894.0, 467699.0, 477436.0, 479044.0, 113989.4300528492, 114845.0, 114903.42548287204, 115472.0, 116364.0, 1149.6091328948198, 1164.7321116143335, 1166.2943918928927, 1171.2094336323119, 1173.02052785923, 17618.647627047132, 18009.459716208534, 18103.81896181074, 18113.36603218881, 18264.908675456536, 52351.47648523466, 52475.0, 53269.0, 53328.20007699965, 54273.18590221229, 63850.361496384445, 64962.67518662376, 65469.672651636436, 65476.67261663661, 65799.67100164469, 20163.495912602302, 20316.695249570974, 20461.69307460419, 20682.0, 20703.58592828105, 22965.77034229703, 23146.652800208347, 23182.76817231806, 23282.53434931258, 23636.29091127269, 18274.725879111556, 18362.724559131355, 18608.255669773058, 18623.0, 18858.717119243498, 16624.667506650043, 16633.667326653158, 16657.66684666324, 16987.40544080951, 17284.56788580245, 17629.20668569892, 17717.84833985787, 18748.81251187525, 19176.90411547989, 19278.036098195316, 18231.544211394823, 18477.81522184761, 18554.907225463787, 18625.53436164107, 18819.341323053628, 17296.82703172952, 17803.0, 17836.643267134845, 18223.362182323555, 18306.725399118757], "value": 12687.118070302526, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.61296224095, 1387.7987691784692, 1397.043025527513, 1401.3133564553373, 1402.8597140285979, 15032.323545440455, 15646.530604081867, 15759.448419305327, 15772.526824195264, 15776.842231577695, 15343.539693809176, 15378.0, 15447.382104715825, 15566.533004009869, 15577.0, 2742.9725702743017, 2840.772738180951, 2847.4162796626747, 2849.3731379096566, 2852.0, 2618.829776064559, 2731.740484653965, 2778.597103420003, 2783.1650504848567, 2786.4427114577065, 2771.459565384751, 2815.366542527925, 2816.070696670094, 2816.7183931311206, 2818.0700368878324, 2488.6515887775727, 2512.786413154866, 2526.178991827654, 2530.0, 2534.2017264561605, 2557.041109583906, 2625.501154780605, 2640.762331390184, 2664.920052398412, 2680.0, 14539.0, 14752.26238688072, 14786.556403307917, 14804.0, 14810.851891481163, 7879.684812607489, 8127.268545830903, 8153.959230203811, 8155.877661835078, 8172.6322315495945, 5438.91841622376, 5706.400827913051, 5727.484526392603, 5799.333076696192, 5806.767729290823, 1907.761529808774, 1908.9713654295197, 1915.8658893877296, 1942.1939894943582, 1954.5895361974003, 26338.86830565835, 26777.330566735793, 26953.73046269532, 27000.0, 27068.864655676596, 6949.374556289857, 7073.92926070743, 7187.676554555058, 7312.670929808171, 7360.153582337993, 20055.29806456767, 20060.197592096443, 20061.191433199365, 20083.19667213295, 20084.297049603192, 8087.959560202161, 8242.876356854653, 8252.422330436812, 8318.168183181633, 8322.916770832335, 7201.567905925661, 7262.745803896838, 7351.44864135192, 7394.963025184839, 7426.702931882773, 5562.082256427644, 5723.170140329629, 5781.103928891029, 5799.623024503394, 5809.0, 1713.9828601713823, 1740.3647668601122, 1755.3943889358152, 1770.150327842617, 1778.4486809088964, 879.3404946290283, 893.7363477774072, 896.9730908072638, 898.8966268879032, 914.1681070226063, 7443.627818609048, 7506.962465187639, 7538.924610753932, 7553.0, 7571.848563028819, 683.2654895986834, 719.5502810743285, 719.802054435024, 720.8197950512372, 727.3490226247479, 4283.892902677396, 4284.592963668447, 4293.69944103916, 5279.436594464539, 5526.723663816873, 20380.38858834237, 20510.282140125026, 20860.47848803792, 21584.0, 21593.0, 20890.268840590506, 21285.0, 21435.356939291847, 21440.892795536234, 21457.78542214558, 10280.177585793268, 10312.02035806597, 10434.426106564211, 10589.682309530726, 10647.733806654896, 8111.513309201467, 8414.4109912308, 8485.490870547786, 8485.618147183268, 8500.404971651926, 18013.819861801214, 18031.81968180354, 18436.723449148543, 18575.53561160982, 18838.52903677364, 18858.24567017304, 18858.339958101402, 19123.426297211106, 19259.22963081461, 19497.0, 12184.939075304566, 12244.632661020183, 12321.691957701129, 12390.62828115158, 12398.690032749253, 13721.794173087212, 14002.929985350009, 14014.789778153132, 14018.0, 14021.29893505341, 11289.0, 11382.54469821231, 11418.771624567627, 11612.187146899636, 11777.823332650189, 10461.26771126014, 10527.263091583516, 10893.836592450962, 10918.399488028235, 10977.560897564008, 10083.941186175345, 10148.57919891201, 10168.237382196217, 10195.796084078425, 10219.029192226726, 7308.671109800178, 7309.0, 7365.926340736524, 7367.889481657672, 7426.814329641802, 7161.785146445406, 7177.246389129066, 7273.763460211882, 7293.0, 7328.743493977685], "value": 6696.21462187356, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.3399813118304, 503.94926578084716, 521.6009752539308, 529.6890196763014, 530.411243519693, 6134.944793494179, 6213.596116252441, 6263.060540918858, 6283.780067697631, 6365.936340636592, 6122.510199184066, 6132.0, 6143.911070236119, 6161.229846269216, 6165.903592778454, 4871.025794841028, 4909.950900491003, 4939.629527785412, 4958.132326842806, 4968.70187788732, 4913.336699545552, 4974.283872064132, 4984.476629953857, 5009.774560144802, 5026.522480364378, 4877.8780530486665, 4885.413750349945, 4890.14422476067, 4933.161362568372, 4937.80248790048, 4927.162382394984, 4933.161362568354, 4934.111859865223, 4974.303597496353, 4988.700677959334, 4453.487848897354, 4457.799399027019, 4464.330350447426, 4474.105178964221, 4494.438195225597, 6031.909521357183, 6072.878542429126, 6093.086037094427, 6097.3292937776805, 6179.783707570258, 5577.191307260465, 5586.41342659019, 5600.747966341524, 5605.831825045255, 5644.717764111778, 6557.606543607351, 6587.308332625101, 6588.901166482507, 6591.40677339037, 6594.604323740591, 4808.3989501312335, 4815.374001379833, 4822.300766388889, 4828.299896514985, 4853.635977301681, 6843.8973415398805, 6844.247132815436, 6923.376896079327, 6930.896036559456, 6978.988046733246, 4940.580050695731, 4961.70229786214, 4962.6774259673, 4971.45314015458, 4977.800887964513, 4939.53074457926, 5045.47022562633, 5047.95557799092, 5052.141136006888, 5070.949290507121, 5581.888362232733, 5585.273914391103, 5587.469190426984, 5619.157126430986, 5669.886602267931, 6211.7388371105535, 6329.303776584572, 6380.9361906380345, 6458.773942911976, 6602.0, 1700.396359292458, 1701.4385252866525, 1720.6816738903342, 1722.9496898690518, 1723.8967061080918, 1199.8560172779323, 1202.9939850300693, 1205.8673545909942, 1208.1274025260811, 1221.4015132584968, 5652.3217213934595, 5702.51528620072, 5801.7389217485315, 5802.593818432753, 5817.534597232211, 6746.932530674729, 6753.4751716350165, 6792.490563207681, 6799.354061364163, 6815.807233734076, 5804.593678442553, 5804.970975145097, 5809.302883653904, 5847.181394604759, 5867.882642347129, 3546.858125674944, 3581.265840502743, 3594.6944509716445, 3604.945925811115, 3617.149969757105, 6540.149780528501, 6555.868882622321, 6566.967165164144, 6568.408843204134, 6572.704228309737, 6812.591244525344, 6878.58728476293, 6904.689288982008, 6930.158634959643, 6955.339242771928, 6436.35636436362, 6444.806655800334, 6452.741890324334, 6537.215534135839, 6541.509386796104, 6679.899801503078, 6698.765543205965, 6734.663266836541, 6756.45948324123, 6768.14215896934, 6624.701888414937, 6668.866622667617, 6781.287485006037, 6791.151106111736, 6793.558418702769, 6311.400416960381, 6465.870682586228, 6569.704363303567, 6584.7036883341325, 6605.47156227491, 4871.293662419001, 4902.975485122694, 4910.361652985089, 4931.926021109614, 4944.456109827988, 6782.320199062631, 6783.321667833177, 6798.694058767268, 6804.931950680628, 6831.282715315019, 6485.3514648534765, 6491.642959637265, 6500.067459187124, 6567.376099270562, 6574.737010519717, 6364.840878978062, 6383.457406120346, 6405.615663060231, 6414.743410263537, 6475.481961442979, 6430.263828766113, 6466.805995820133, 6468.15913931186, 6486.643234622141, 6528.314526974599, 6199.225096862892, 6576.473882089517, 6654.500912431684, 6661.433778128913, 6678.130123565409, 6183.350748171557, 6210.161628180319, 6231.937680623136, 6292.622442653455, 6320.6839658016], "value": 5039.018738675776, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [891.3760367742582, 913.6847787513306, 917.5045475443261, 924.4684306523746, 938.2494004796164, 18510.90744546277, 19239.71140432893, 19302.90348548257, 20862.0, 22960.65559016612, 20737.688934665955, 20906.372808815722, 21038.684419733716, 21296.148154073857, 21414.143434262613, 960.394951180757, 978.1783302026297, 979.4661909259471, 979.6130528441262, 980.6469670918464, 966.3718582921088, 979.5151400056982, 989.9802003959917, 991.1476130527741, 998.5057396588699, 1046.3146638951462, 1052.27393098762, 1052.899974502421, 1053.3048188195792, 1053.7576357437795, 1039.2153923787569, 1039.4127318065307, 1040.0587468341164, 1040.6253748650518, 1045.2526443592867, 762.371043888794, 767.1063211358816, 768.7962689887185, 772.7140957845577, 772.8879312499656, 20144.49638759043, 20281.492962675904, 20481.692774608393, 20533.38399848007, 20545.0, 21656.675149872764, 21725.67411488829, 22379.776202238096, 22384.32847014576, 22399.776002240094, 16857.91571042137, 16968.0, 17086.14569271544, 17123.400680976105, 17213.225404856687, 3769.736118471708, 3845.557760857509, 3847.5575308839284, 3867.961320386816, 3868.883933481972, 151298.0, 151771.0, 152770.23614881854, 152838.0, 154765.0, 16578.83421165773, 16752.41366552165, 16864.747028794576, 17060.57348566271, 17098.0596067215, 26955.865220674164, 30662.233444163627, 30695.539566906515, 30699.38601227963, 30729.078127656205, 9114.680986165453, 9248.537573121317, 9278.628854845865, 9303.53482325881, 9320.95339523298, 4384.276594361958, 4448.110377924428, 4474.060447306102, 4476.552344765498, 4482.843100491467, 5279.155335146358, 5351.25082488452, 5400.243965844785, 5411.080116380225, 5445.891082178414, 1138.0895283773114, 1155.6764106050318, 1161.6631176958756, 1182.5624518928053, 1186.2941549777868, 686.2862622872157, 712.8182313510022, 713.1549114299571, 718.4862823081418, 735.9632018399059, 12020.939895300642, 12273.815892761615, 12375.69060773488, 13113.409896554678, 13160.407781649848, 708.242180866468, 710.6979533698261, 713.6931119618614, 715.4348065028569, 727.0620899040179, 5727.3699893011735, 5759.971200143972, 5853.297604287428, 5880.911786323209, 5891.646501209942, 124114.0, 127928.0, 128678.35660821636, 128788.0, 129103.0, 108456.91543084469, 109133.45433272782, 109357.45321273502, 110019.44990274997, 113332.43333783279, 98529.50735246278, 100846.49576752217, 101610.44363447392, 101730.49134754279, 104395.0, 10797.892021079688, 10803.45982700846, 10898.836517452402, 10905.672829815117, 11171.72070698239, 44378.77810610926, 44822.3276650857, 45060.07109538001, 45597.088058239315, 45793.313100304185, 57041.71479142578, 57213.42786572081, 57498.70005199745, 57932.42067579439, 59298.0, 15986.68026639484, 16047.759283610989, 16066.357345706041, 16154.434594789125, 16166.515004549883, 18166.72749908726, 18262.817371826113, 18318.0, 18438.446846594623, 18504.907475462536, 15804.76292855585, 15912.681746365239, 15922.60193495172, 15965.600859978593, 16084.758728619314, 16891.91554042222, 16920.830791692417, 17107.657846842743, 17176.22706978214, 17449.214785334945, 15170.393184272505, 15434.768478472608, 15502.84497155014, 15604.92197539005, 15613.84386156124, 12013.219140755822, 12239.20445171061, 12266.0, 12267.570635028089, 12417.813732794197, 12520.436580353724, 12602.180858244184, 12616.936915315364, 12803.10378273512, 12822.358882055672], "value": 9224.789093690979, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1425.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 107.0, 109.0, 109.0, 111.0, 108.0, 110.0, 108.0, 107.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 120.0, 120.0, 120.0, 116.0, 150.0, 118.0, 116.0, 121.0], "value": 121.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 164.0, 163.0, 167.0, 167.0, 162.0, 167.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 84.0, 75.0, 75.0, 74.0, 74.0, 74.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 82.0, 84.0, 78.0, 78.0, 78.0, 79.0, 78.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 114.0, 114.0, 115.0, 114.0, 114.0, 120.0, 113.0, 119.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 148.0, 148.0, 147.0, 149.0, 149.0, 150.0, 148.0, 148.0, 148.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 56.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 37.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 37.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 73.0, 76.0, 74.0, 73.0, 78.0, 73.0, 74.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 115.0, 116.0, 113.0, 121.0, 114.0, 116.0, 116.0, 113.0], "value": 115.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 168.0, 166.0, 171.0, 173.0, 169.0, 177.0, 168.0, 171.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 66.0, 72.0, 66.0, 65.0, 65.0, 68.0, 67.0, 76.0], "value": 68.0, "unit": "score"}]}]} 01:14:51 INFO - Return code: 0 01:14:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:14:51 INFO - # TBPL SUCCESS # 01:14:51 INFO - Running post-action listener: _package_coverage_data 01:14:51 INFO - Running post-action listener: _resource_record_post_action 01:14:51 INFO - [mozharness: 2017-09-14 08:14:51.422832Z] Finished run-tests step (success) 01:14:51 INFO - Running post-run listener: _resource_record_post_run 01:14:51 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 10653696; Write bytes: 525647872; Read time: 3364; Write time: 498636 01:14:51 INFO - TinderboxPrint: CPU usage
13.1% 01:14:51 INFO - TinderboxPrint: I/O read bytes / time
10,653,696 / 3,364 01:14:51 INFO - TinderboxPrint: I/O write bytes / time
525,647,872 / 498,636 01:14:51 INFO - TinderboxPrint: CPU idle
8,253.2 (86.8%) 01:14:51 INFO - TinderboxPrint: CPU user
1,194.5 (12.6%) 01:14:51 INFO - TinderboxPrint: Swap in / out
0 / 0 01:14:51 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 8192; Write bytes: 160317440; Read time: 160; Write time: 86596 01:14:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 01:14:51 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8417280; Write bytes: 365330432; Read time: 2996; Write time: 412040 01:14:52 INFO - Running post-run listener: _upload_blobber_files 01:14:52 INFO - Blob upload gear active. 01:14:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:14:52 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:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:14:52 INFO - (blobuploader) - INFO - Open directory for files ... 01:14:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:14:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:14:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:14:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:14:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:14:59 INFO - (blobuploader) - INFO - Done attempting. 01:14:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:14:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:14:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:15:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:00 INFO - (blobuploader) - INFO - Done attempting. 01:15:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 01:15:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 01:15:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:01 INFO - (blobuploader) - INFO - Done attempting. 01:15:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 01:15:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:15:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:15:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 01:15:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:15:02 INFO - (blobuploader) - INFO - Done attempting. 01:15:02 INFO - (blobuploader) - INFO - Iteration through files over. 01:15:02 INFO - Return code: 0 01:15:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:15:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:15:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ec07e93803fb8934d3253dadcaface105e054f698908f0d44d0df8c947d44b127d890be0d2f5e76dc6352822f8bac1adefa34e9d4a29ac2bc76946d56021b9d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38443cc9d640e819fce489150f3e2c9b3dc9ca39c3293931281612419a889b70fc18f962c026348e1c8d37e5bff941abec991cbca8f508e92266adf9937b4ecc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/372e3aaf849bea9d9ba21cc2769d9eab7f56e058af11caf0cd2eeef00be3bf78e5f9dc3fae498fd0a2b542fe6094391d1d4c572795b81c28f0b1e6e3cf595734", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cc749134f7e224474cda1806d62b3f0db6d50dbc3c1ada7dd1011f30e64d49fb345e4f998fbd63d89fa905a8f93b1a7045f7a0ae8bc7bb2902ca7e999d552bd9"} 01:15:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:15:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:15:02 INFO - Contents: 01:15:02 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ec07e93803fb8934d3253dadcaface105e054f698908f0d44d0df8c947d44b127d890be0d2f5e76dc6352822f8bac1adefa34e9d4a29ac2bc76946d56021b9d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38443cc9d640e819fce489150f3e2c9b3dc9ca39c3293931281612419a889b70fc18f962c026348e1c8d37e5bff941abec991cbca8f508e92266adf9937b4ecc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/372e3aaf849bea9d9ba21cc2769d9eab7f56e058af11caf0cd2eeef00be3bf78e5f9dc3fae498fd0a2b542fe6094391d1d4c572795b81c28f0b1e6e3cf595734", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cc749134f7e224474cda1806d62b3f0db6d50dbc3c1ada7dd1011f30e64d49fb345e4f998fbd63d89fa905a8f93b1a7045f7a0ae8bc7bb2902ca7e999d552bd9"} 01:15:02 INFO - Running post-run listener: copy_logs_to_upload_dir 01:15:02 INFO - Copying logs to upload dir... 01:15:02 INFO - mkdir: /builds/slave/test/build/upload/logs 01:15:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.473179 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-14 01:15:03.002236) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 01:15:03.007162) ========= 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=438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ec07e93803fb8934d3253dadcaface105e054f698908f0d44d0df8c947d44b127d890be0d2f5e76dc6352822f8bac1adefa34e9d4a29ac2bc76946d56021b9d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38443cc9d640e819fce489150f3e2c9b3dc9ca39c3293931281612419a889b70fc18f962c026348e1c8d37e5bff941abec991cbca8f508e92266adf9937b4ecc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/372e3aaf849bea9d9ba21cc2769d9eab7f56e058af11caf0cd2eeef00be3bf78e5f9dc3fae498fd0a2b542fe6094391d1d4c572795b81c28f0b1e6e3cf595734", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cc749134f7e224474cda1806d62b3f0db6d50dbc3c1ada7dd1011f30e64d49fb345e4f998fbd63d89fa905a8f93b1a7045f7a0ae8bc7bb2902ca7e999d552bd9"} build_url:https://queue.taskcluster.net/v1/task/L_3yr4h9Spyt82QzKDJcnw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011203 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-Non-PGO/sha512/8ec07e93803fb8934d3253dadcaface105e054f698908f0d44d0df8c947d44b127d890be0d2f5e76dc6352822f8bac1adefa34e9d4a29ac2bc76946d56021b9d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38443cc9d640e819fce489150f3e2c9b3dc9ca39c3293931281612419a889b70fc18f962c026348e1c8d37e5bff941abec991cbca8f508e92266adf9937b4ecc", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/372e3aaf849bea9d9ba21cc2769d9eab7f56e058af11caf0cd2eeef00be3bf78e5f9dc3fae498fd0a2b542fe6094391d1d4c572795b81c28f0b1e6e3cf595734", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cc749134f7e224474cda1806d62b3f0db6d50dbc3c1ada7dd1011f30e64d49fb345e4f998fbd63d89fa905a8f93b1a7045f7a0ae8bc7bb2902ca7e999d552bd9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 01:15:03.042738) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 01:15:03.043105) ========= 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=438111f3d31ce799eff2119d000001bc-1505374989.429790-885682327 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 01:15:03.127754) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 01:15:03.128099) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 01:15:03.128455) ========= ========= Total master_lag: 0.42 =========