builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-046 starttime: 1505307090.75 results: success (0) revision: 1888ec2f277f6bb26271b8808e08914a21db9efe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 05:51:30.751669) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 05:51:30.752020) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 05:51:30.752445) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 05:51:30.803927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 05:51:30.804292) ========= 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=652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 05:51:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 217M=0s 2017-09-13 05:51:30 (217 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163771 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 05:51:30.993850) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 05:51:30.994158) ========= 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=652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016779 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 05:51:31.044757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-13 05:51:31.045063) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1888ec2f277f6bb26271b8808e08914a21db9efe --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 1888ec2f277f6bb26271b8808e08914a21db9efe --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=652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 05:51:31,098 truncating revision to first 12 chars 2017-09-13 05:51:31,099 Setting DEBUG logging. 2017-09-13 05:51:31,099 attempt 1/10 2017-09-13 05:51:31,099 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1888ec2f277f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 05:51:31,749 unpacking tar archive at: mozilla-central-1888ec2f277f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.058049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-13 05:51:32.119405) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 05:51:32.119736) ========= script_repo_revision: 1888ec2f277f6bb26271b8808e08914a21db9efe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 05:51:32.120098) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 05:51:32.120371) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 05:51:32.133881) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-13 05:51:32.134285) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:51:32 INFO - MultiFileLogger online at 20170913 05:51:32 in /builds/slave/test 05:51:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:51:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:51:32 INFO - {'append_to_log': False, 05:51:32 INFO - 'base_work_dir': '/builds/slave/test', 05:51:32 INFO - 'blob_upload_branch': 'Firefox', 05:51:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:51:32 INFO - 'branch': 'Firefox', 05:51:32 INFO - 'buildbot_json_path': 'buildprops.json', 05:51:32 INFO - 'code_coverage': False, 05:51:32 INFO - 'config_files': ('talos/linux_config.py',), 05:51:32 INFO - 'default_actions': ('clobber', 05:51:32 INFO - 'read-buildbot-config', 05:51:32 INFO - 'download-and-extract', 05:51:32 INFO - 'populate-webroot', 05:51:32 INFO - 'create-virtualenv', 05:51:32 INFO - 'install', 05:51:32 INFO - 'setup-mitmproxy', 05:51:32 INFO - 'run-tests'), 05:51:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:51:32 INFO - 'disable_ccov_upload': False, 05:51:32 INFO - 'disable_stylo': False, 05:51:32 INFO - 'download_minidump_stackwalk': True, 05:51:32 INFO - 'download_symbols': 'ondemand', 05:51:32 INFO - 'enable_stylo': False, 05:51:32 INFO - 'enable_webrender': False, 05:51:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:51:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:51:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:51:32 INFO - 'gecko_profile': False, 05:51:32 INFO - 'gecko_profile_interval': 0, 05:51:32 INFO - 'installer_path': 'installer.exe', 05:51:32 INFO - 'log_level': 'info', 05:51:32 INFO - 'log_name': 'talos', 05:51:32 INFO - 'log_to_console': True, 05:51:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:51:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:51:32 INFO - 'opt_config_files': (), 05:51:32 INFO - 'pip_index': False, 05:51:32 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 05:51:32 INFO - 'system_bits': '32', 05:51:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:51:32 INFO - 'title': 'talos-linux64-ix-046', 05:51:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:51:32 INFO - 'use_talos_json': True, 05:51:32 INFO - 'verify': 'False', 05:51:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:51:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:51:32 INFO - 'work_dir': 'build'} 05:51:32 INFO - [mozharness: 2017-09-13 12:51:32.429462Z] Running clobber step. 05:51:32 INFO - Running pre-action listener: _resource_record_pre_action 05:51:32 INFO - Running main action method: clobber 05:51:32 INFO - rmtree: /builds/slave/test/build 05:51:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:51:33 INFO - Running post-action listener: _resource_record_post_action 05:51:33 INFO - [mozharness: 2017-09-13 12:51:33.393818Z] Finished clobber step (success) 05:51:33 INFO - [mozharness: 2017-09-13 12:51:33.393915Z] Running read-buildbot-config step. 05:51:33 INFO - Running pre-action listener: _resource_record_pre_action 05:51:33 INFO - Running main action method: read_buildbot_config 05:51:33 INFO - Using buildbot properties: 05:51:33 INFO - { 05:51:33 INFO - "project": "", 05:51:33 INFO - "product": "firefox", 05:51:33 INFO - "who": "archaeopteryx@coole-files.de", 05:51:33 INFO - "installer_path": "public/build/target.tar.bz2", 05:51:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 05:51:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:51:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 05:51:33 INFO - "stage_platform": "linux64-pgo", 05:51:33 INFO - "basedir": "/builds/slave/test", 05:51:33 INFO - "buildnumber": 12, 05:51:33 INFO - "platform": "ubuntu64_hw", 05:51:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:51:33 INFO - "slavebuilddir": "test", 05:51:33 INFO - "taskId": "c2XK9TNgQwq_vIyPEOzxeA", 05:51:33 INFO - "branch": "mozilla-central", 05:51:33 INFO - "script_repo_revision": "production", 05:51:33 INFO - "revision": "1888ec2f277f6bb26271b8808e08914a21db9efe", 05:51:33 INFO - "slavename": "talos-linux64-ix-046", 05:51:33 INFO - "repo_path": "mozilla-central" 05:51:33 INFO - } 05:51:33 INFO - Finding installer, test and symbols from parent task. 05:51:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c2XK9TNgQwq_vIyPEOzxeA'}, attempt #1 05:51:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c2XK9TNgQwq_vIyPEOzxeA'}, attempt #1 05:51:34 INFO - Task dependencies: MRxBWqUrQPGKnk9jTZc_NQ 05:51:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ'}, attempt #1 05:51:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.tar.bz2 05:51:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.test_packages.json 05:51:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.crashreporter-symbols.zip 05:51:35 INFO - Running post-action listener: _resource_record_post_action 05:51:35 INFO - [mozharness: 2017-09-13 12:51:35.541972Z] Finished read-buildbot-config step (success) 05:51:35 INFO - [mozharness: 2017-09-13 12:51:35.542187Z] Running download-and-extract step. 05:51:35 INFO - Running pre-action listener: _resource_record_pre_action 05:51:35 INFO - Running main action method: download_and_extract 05:51:35 INFO - mkdir: /builds/slave/test/build/tests 05:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:35 INFO - trying https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.test_packages.json 05:51:35 INFO - Downloading https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:51:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:51:36 INFO - Downloaded 989 bytes. 05:51:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:51:36 INFO - Using the following test package requirements: 05:51:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:51:36 INFO - u'common': [u'target.common.tests.zip'], 05:51:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:51:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:51:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:51:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:51:36 INFO - u'mozbase': [u'target.common.tests.zip'], 05:51:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:51:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:51:36 INFO - u'web-platform': [u'target.common.tests.zip', 05:51:36 INFO - u'target.web-platform.tests.tar.gz'], 05:51:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:51:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 05:51:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.common.tests.zip 05:51:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:51:36 INFO - Fetch https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.common.tests.zip into memory 05:51:37 INFO - Content-Length response header: 55167449 05:51:37 INFO - Bytes received: 55167449 05:51:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.talos.tests.zip 05:51:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:51:49 INFO - Fetch https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.talos.tests.zip into memory 05:51:50 INFO - Content-Length response header: 14499226 05:51:50 INFO - Bytes received: 14499226 05:51: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')]} 05:51:50 INFO - trying https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.tar.bz2 05:51:50 INFO - Downloading https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:51:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:51:51 INFO - Downloaded 62007993 bytes. 05:51:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.tar.bz2 05:51:51 INFO - mkdir: /builds/slave/test/properties 05:51:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:51:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:51:51 INFO - Contents: 05:51:51 INFO - build_url:https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.tar.bz2 05:51:51 INFO - Running post-action listener: _resource_record_post_action 05:51:51 INFO - Running post-action listener: find_tests_for_verification 05:51:51 INFO - Running post-action listener: set_extra_try_arguments 05:51:51 INFO - [mozharness: 2017-09-13 12:51:51.988463Z] Finished download-and-extract step (success) 05:51:51 INFO - [mozharness: 2017-09-13 12:51:51.988721Z] Running populate-webroot step. 05:51:51 INFO - Running pre-action listener: _resource_record_pre_action 05:51:51 INFO - Running main action method: populate_webroot 05:51:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:51:52 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:51:52 INFO - 'tests': ['tresize', 05:51:52 INFO - 'tcanvasmark']}, 05:51:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:51:52 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:51:52 INFO - 'tests': ['dromaeo_css', 05:51:52 INFO - 'kraken']}, 05:51:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:51:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:52 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:51:52 INFO - 'talos_options': ['--disable-stylo'], 05:51:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:51:52 INFO - 'tests': ['damp', 'tps']}, 05:51:52 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:51:52 INFO - 'talos_options': ['--disable-stylo'], 05:51:52 INFO - 'tests': ['damp', 'tps']}, 05:51:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:51:52 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:51:52 INFO - 'tests': ['dromaeo_dom']}, 05:51:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:51:52 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:51:52 INFO - 'tests': ['basic_compositor_video', 05:51:52 INFO - 'glvideo']}, 05:51:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:51:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:51:52 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:51:52 INFO - 'talos_options': ['--disable-stylo'], 05:51:52 INFO - 'tests': ['ts_paint_webext', 05:51:52 INFO - 'tp5o_webext']}, 05:51:52 INFO - 'other-e10s': {'tests': ['a11yr', 05:51:52 INFO - 'ts_paint', 05:51:52 INFO - 'tpaint', 05:51:52 INFO - 'sessionrestore', 05:51:52 INFO - 'sessionrestore_many_windows', 05:51:52 INFO - 'sessionrestore_no_auto_restore', 05:51:52 INFO - 'tabpaint']}, 05:51:52 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:51:52 INFO - 'tests': ['a11yr', 05:51:52 INFO - 'ts_paint', 05:51:52 INFO - 'tpaint', 05:51:52 INFO - 'sessionrestore', 05:51:52 INFO - 'sessionrestore_many_windows', 05:51:52 INFO - 'sessionrestore_no_auto_restore', 05:51:52 INFO - 'tabpaint']}, 05:51:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:51:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:51:52 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:51:52 INFO - 'tests': ['bloom_basic_singleton']}, 05:51:52 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:51:52 INFO - 'tests': ['bloom_basic']}, 05:51:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:51:52 INFO - 'tsvgr_opacity', 05:51:52 INFO - 'tart', 05:51:52 INFO - 'tscrollx', 05:51:52 INFO - 'tsvg_static']}, 05:51:52 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:51:52 INFO - 'tests': ['tsvgx', 05:51:52 INFO - 'tsvgr_opacity', 05:51:52 INFO - 'tart', 05:51:52 INFO - 'tscrollx', 05:51:52 INFO - 'tsvg_static']}, 05:51:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:51:52 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:51:52 INFO - 'talos_options': ['--disable-stylo'], 05:51:52 INFO - 'tests': ['tp5o']}, 05:51:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:51:52 INFO - 'talos_options': ['--mitmproxy', 05:51:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:51:52 INFO - '--firstNonBlankPaint'], 05:51:52 INFO - 'tests': ['tp6_google', 05:51:52 INFO - 'tp6_youtube', 05:51:52 INFO - 'tp6_amazon', 05:51:52 INFO - 'tp6_facebook']}, 05:51:52 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:51:52 INFO - 'talos_options': ['--disable-stylo', 05:51:52 INFO - '--mitmproxy', 05:51:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:51:52 INFO - '--firstNonBlankPaint'], 05:51:52 INFO - 'tests': ['tp6_google', 05:51:52 INFO - 'tp6_youtube', 05:51:52 INFO - 'tp6_amazon', 05:51:52 INFO - 'tp6_facebook']}, 05:51:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:51:52 INFO - 'talos_options': ['--stylo-threads=1', 05:51:52 INFO - '--mitmproxy', 05:51:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:51:52 INFO - '--firstNonBlankPaint'], 05:51:52 INFO - 'tests': ['tp6_google', 05:51:52 INFO - 'tp6_youtube', 05:51:52 INFO - 'tp6_amazon', 05:51:52 INFO - 'tp6_facebook']}, 05:51:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:51:52 INFO - 'talos_options': ['--xperf_path', 05:51:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:52 INFO - 'tests': ['tp5n']}, 05:51:52 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:51:52 INFO - 'talos_options': ['--disable-stylo', 05:51:52 INFO - '--xperf_path', 05:51:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:52 INFO - 'tests': ['tp5n']}}} 05:51:52 INFO - Running post-action listener: _resource_record_post_action 05:51:52 INFO - [mozharness: 2017-09-13 12:51:52.007544Z] Finished populate-webroot step (success) 05:51:52 INFO - [mozharness: 2017-09-13 12:51:52.007633Z] Running create-virtualenv step. 05:51:52 INFO - Running pre-action listener: _resource_record_pre_action 05:51:52 INFO - Running main action method: create_virtualenv 05:51:52 INFO - Creating virtualenv /builds/slave/test/build/venv 05:51:52 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:51:52 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:51:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:51:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:51:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:51:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:51:53 INFO - Installing pip...............done. 05:51:53 INFO - Return code: 0 05:51:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:51:53 INFO - Reading from file tmpfile_stdout 05:51:53 INFO - Output received: 05:51:53 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:51:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51: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')]} 05:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194f090>, '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 0x194fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', '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 05:51:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:51:53 INFO - Using env: {'DISPLAY': ':0', 05:51:53 INFO - 'HOME': '/home/cltbld', 05:51:53 INFO - 'LANG': 'en_US.UTF-8', 05:51:53 INFO - 'LANGUAGE': 'en_US:en', 05:51:53 INFO - 'LOGNAME': 'cltbld', 05:51:53 INFO - 'MAIL': '/var/mail/cltbld', 05:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:53 INFO - 'MOZ_NO_REMOTE': '1', 05:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:53 INFO - 'NO_EM_RESTART': '1', 05:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:53 INFO - 'PWD': '/builds/slave/test', 05:51:53 INFO - 'SHELL': '/bin/bash', 05:51:53 INFO - 'SHLVL': '1', 05:51:53 INFO - 'TERM': 'linux', 05:51:53 INFO - 'TMOUT': '86400', 05:51:53 INFO - 'USER': 'cltbld', 05:51:53 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', 05:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:53 INFO - '_': '/tools/buildbot/bin/python'} 05:51:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:51:55 INFO - Downloading/unpacking pip>=1.5 05:51:55 INFO - Running setup.py egg_info for package pip 05:51:55 INFO - warning: no files found matching 'pip/cacert.pem' 05:51:55 INFO - warning: no files found matching '*.html' under directory 'docs' 05:51:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:51:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:51:55 INFO - Installing collected packages: pip 05:51:55 INFO - Found existing installation: pip 1.1 05:51:55 INFO - Uninstalling pip: 05:51:55 INFO - Successfully uninstalled pip 05:51:55 INFO - Running setup.py install for pip 05:51:55 INFO - warning: no files found matching 'pip/cacert.pem' 05:51:55 INFO - warning: no files found matching '*.html' under directory 'docs' 05:51:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:51:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:51:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:51:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:51:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:51:55 INFO - Successfully installed pip 05:51:55 INFO - Cleaning up... 05:51:55 INFO - Return code: 0 05:51:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194f090>, '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 0x194fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', '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 05:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:51:55 INFO - Using env: {'DISPLAY': ':0', 05:51:55 INFO - 'HOME': '/home/cltbld', 05:51:55 INFO - 'LANG': 'en_US.UTF-8', 05:51:55 INFO - 'LANGUAGE': 'en_US:en', 05:51:55 INFO - 'LOGNAME': 'cltbld', 05:51:55 INFO - 'MAIL': '/var/mail/cltbld', 05:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:55 INFO - 'MOZ_NO_REMOTE': '1', 05:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:55 INFO - 'NO_EM_RESTART': '1', 05:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:55 INFO - 'PWD': '/builds/slave/test', 05:51:55 INFO - 'SHELL': '/bin/bash', 05:51:55 INFO - 'SHLVL': '1', 05:51:55 INFO - 'TERM': 'linux', 05:51:55 INFO - 'TMOUT': '86400', 05:51:55 INFO - 'USER': 'cltbld', 05:51:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', 05:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:55 INFO - '_': '/tools/buildbot/bin/python'} 05:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:55 INFO - Downloading/unpacking psutil>=3.1.1 05:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:51:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:56 INFO - Installing collected packages: psutil 05:51:56 INFO - Running setup.py install for psutil 05:51:56 INFO - building 'psutil._psutil_linux' extension 05:51:56 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 05:51:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:51:58 INFO - building 'psutil._psutil_posix' extension 05:51:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:51:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:51:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:59 INFO - Successfully installed psutil 05:51:59 INFO - Cleaning up... 05:51:59 INFO - Return code: 0 05:51:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194f090>, '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 0x194fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', '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 05:51:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:51:59 INFO - Using env: {'DISPLAY': ':0', 05:51:59 INFO - 'HOME': '/home/cltbld', 05:51:59 INFO - 'LANG': 'en_US.UTF-8', 05:51:59 INFO - 'LANGUAGE': 'en_US:en', 05:51:59 INFO - 'LOGNAME': 'cltbld', 05:51:59 INFO - 'MAIL': '/var/mail/cltbld', 05:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:59 INFO - 'MOZ_NO_REMOTE': '1', 05:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:59 INFO - 'NO_EM_RESTART': '1', 05:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:59 INFO - 'PWD': '/builds/slave/test', 05:51:59 INFO - 'SHELL': '/bin/bash', 05:51:59 INFO - 'SHLVL': '1', 05:51:59 INFO - 'TERM': 'linux', 05:51:59 INFO - 'TMOUT': '86400', 05:51:59 INFO - 'USER': 'cltbld', 05:51:59 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', 05:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:59 INFO - '_': '/tools/buildbot/bin/python'} 05:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:52:00 INFO - Installing collected packages: mozsystemmonitor 05:52:00 INFO - Running setup.py install for mozsystemmonitor 05:52:00 INFO - Successfully installed mozsystemmonitor 05:52:00 INFO - Cleaning up... 05:52:00 INFO - Return code: 0 05:52:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:52:00 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')]} 05:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:00 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')]} 05:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:00 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 0x15df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194f090>, '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 0x194fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', '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 05:52:00 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 05:52:00 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 05:52:00 INFO - Using env: {'DISPLAY': ':0', 05:52:00 INFO - 'HOME': '/home/cltbld', 05:52:00 INFO - 'LANG': 'en_US.UTF-8', 05:52:00 INFO - 'LANGUAGE': 'en_US:en', 05:52:00 INFO - 'LOGNAME': 'cltbld', 05:52:00 INFO - 'MAIL': '/var/mail/cltbld', 05:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:00 INFO - 'MOZ_NO_REMOTE': '1', 05:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:00 INFO - 'NO_EM_RESTART': '1', 05:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:00 INFO - 'PWD': '/builds/slave/test', 05:52:00 INFO - 'SHELL': '/bin/bash', 05:52:00 INFO - 'SHLVL': '1', 05:52:00 INFO - 'TERM': 'linux', 05:52:00 INFO - 'TMOUT': '86400', 05:52:00 INFO - 'USER': 'cltbld', 05:52:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', 05:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:00 INFO - '_': '/tools/buildbot/bin/python'} 05:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:00 INFO - Downloading/unpacking jsonschema==2.5.1 05:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:52:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:02 INFO - Downloading functools32-3.2.3-2.tar.gz 05:52:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:52:02 INFO - warning: no files found matching '*.txt' 05:52:02 INFO - no previously-included directories found matching 'build' 05:52:02 INFO - no previously-included directories found matching 'dist' 05:52:02 INFO - no previously-included directories found matching '.git*' 05:52:02 INFO - Installing collected packages: jsonschema, functools32 05:52:02 INFO - Running setup.py install for functools32 05:52:02 INFO - warning: no files found matching '*.txt' 05:52:02 INFO - no previously-included directories found matching 'build' 05:52:02 INFO - no previously-included directories found matching 'dist' 05:52:02 INFO - no previously-included directories found matching '.git*' 05:52:02 INFO - Successfully installed jsonschema functools32 05:52:02 INFO - Cleaning up... 05:52:02 INFO - Return code: 0 05:52:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194f090>, '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 0x194fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', '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 05:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:52:02 INFO - Using env: {'DISPLAY': ':0', 05:52:02 INFO - 'HOME': '/home/cltbld', 05:52:02 INFO - 'LANG': 'en_US.UTF-8', 05:52:02 INFO - 'LANGUAGE': 'en_US:en', 05:52:02 INFO - 'LOGNAME': 'cltbld', 05:52:02 INFO - 'MAIL': '/var/mail/cltbld', 05:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:02 INFO - 'MOZ_NO_REMOTE': '1', 05:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:02 INFO - 'NO_EM_RESTART': '1', 05:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:02 INFO - 'PWD': '/builds/slave/test', 05:52:02 INFO - 'SHELL': '/bin/bash', 05:52:02 INFO - 'SHLVL': '1', 05:52:02 INFO - 'TERM': 'linux', 05:52:02 INFO - 'TMOUT': '86400', 05:52:02 INFO - 'USER': 'cltbld', 05:52:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', 05:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:02 INFO - '_': '/tools/buildbot/bin/python'} 05:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:52:02 INFO - Cleaning up... 05:52:02 INFO - Return code: 0 05:52:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194f090>, '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 0x194fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', '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 05:52:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:52:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:52:02 INFO - Using env: {'DISPLAY': ':0', 05:52:02 INFO - 'HOME': '/home/cltbld', 05:52:02 INFO - 'LANG': 'en_US.UTF-8', 05:52:02 INFO - 'LANGUAGE': 'en_US:en', 05:52:02 INFO - 'LOGNAME': 'cltbld', 05:52:02 INFO - 'MAIL': '/var/mail/cltbld', 05:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:02 INFO - 'MOZ_NO_REMOTE': '1', 05:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:02 INFO - 'NO_EM_RESTART': '1', 05:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:02 INFO - 'PWD': '/builds/slave/test', 05:52:02 INFO - 'SHELL': '/bin/bash', 05:52:02 INFO - 'SHLVL': '1', 05:52:02 INFO - 'TERM': 'linux', 05:52:02 INFO - 'TMOUT': '86400', 05:52:02 INFO - 'USER': 'cltbld', 05:52:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', 05:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:02 INFO - '_': '/tools/buildbot/bin/python'} 05:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:02 INFO - Downloading/unpacking blobuploader==1.2.4 05:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:03 INFO - Downloading blobuploader-1.2.4.tar.gz 05:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:52:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:52:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:04 INFO - Downloading docopt-0.6.1.tar.gz 05:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:52:04 INFO - Installing collected packages: blobuploader, requests, docopt 05:52:04 INFO - Running setup.py install for blobuploader 05:52:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:52:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:52:04 INFO - Running setup.py install for requests 05:52:05 INFO - Running setup.py install for docopt 05:52:05 INFO - Successfully installed blobuploader requests docopt 05:52:05 INFO - Cleaning up... 05:52:05 INFO - Return code: 0 05:52:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194f090>, '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 0x194fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', '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 05:52:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:52:05 INFO - Using env: {'DISPLAY': ':0', 05:52:05 INFO - 'HOME': '/home/cltbld', 05:52:05 INFO - 'LANG': 'en_US.UTF-8', 05:52:05 INFO - 'LANGUAGE': 'en_US:en', 05:52:05 INFO - 'LOGNAME': 'cltbld', 05:52:05 INFO - 'MAIL': '/var/mail/cltbld', 05:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:05 INFO - 'MOZ_NO_REMOTE': '1', 05:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:05 INFO - 'NO_EM_RESTART': '1', 05:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:05 INFO - 'PWD': '/builds/slave/test', 05:52:05 INFO - 'SHELL': '/bin/bash', 05:52:05 INFO - 'SHLVL': '1', 05:52:05 INFO - 'TERM': 'linux', 05:52:05 INFO - 'TMOUT': '86400', 05:52:05 INFO - 'USER': 'cltbld', 05:52:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', 05:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:05 INFO - '_': '/tools/buildbot/bin/python'} 05:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:05 INFO - Running setup.py (path:/tmp/pip-ECIB6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:05 INFO - Running setup.py (path:/tmp/pip-TlFrfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:05 INFO - Running setup.py (path:/tmp/pip-Rs8VxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:05 INFO - Running setup.py (path:/tmp/pip-Ad8wTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:05 INFO - Running setup.py (path:/tmp/pip-EUllX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:05 INFO - Running setup.py (path:/tmp/pip-mjwHGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:05 INFO - Running setup.py (path:/tmp/pip-Q9vHPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:05 INFO - Running setup.py (path:/tmp/pip-dKzCt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:05 INFO - Running setup.py (path:/tmp/pip-6gU9gT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:05 INFO - Running setup.py (path:/tmp/pip-7vI2Un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:06 INFO - Running setup.py (path:/tmp/pip-I0qCzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:06 INFO - Running setup.py (path:/tmp/pip-xoyeCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:06 INFO - Running setup.py (path:/tmp/pip-I5P4qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:06 INFO - Running setup.py (path:/tmp/pip-Pl_vYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:06 INFO - Running setup.py (path:/tmp/pip-YINssI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:06 INFO - Running setup.py (path:/tmp/pip-IXjVqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:06 INFO - Running setup.py (path:/tmp/pip-CegvcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:52:06 INFO - Running setup.py install for manifestparser 05:52:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:52:06 INFO - Running setup.py install for mozcrash 05:52:06 INFO - Running setup.py install for mozdebug 05:52:06 INFO - Running setup.py install for mozdevice 05:52:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:52:06 INFO - Running setup.py install for mozfile 05:52:07 INFO - Running setup.py install for mozhttpd 05:52:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:52:07 INFO - Running setup.py install for mozinfo 05:52:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:52:07 INFO - Running setup.py install for mozInstall 05:52:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:52:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:52:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:52:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:52:07 INFO - Running setup.py install for mozleak 05:52:07 INFO - Running setup.py install for mozlog 05:52:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:52:07 INFO - Running setup.py install for moznetwork 05:52:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:52:07 INFO - Running setup.py install for mozprocess 05:52:07 INFO - Running setup.py install for mozprofile 05:52:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:52:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:52:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:52:07 INFO - Running setup.py install for mozrunner 05:52:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:52:08 INFO - Running setup.py install for mozscreenshot 05:52:08 INFO - Running setup.py install for moztest 05:52:08 INFO - Running setup.py install for mozversion 05:52:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:52:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:52:08 INFO - Cleaning up... 05:52:08 INFO - Return code: 0 05:52:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194f090>, '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 0x194fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', '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 05:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:52:08 INFO - Using env: {'DISPLAY': ':0', 05:52:08 INFO - 'HOME': '/home/cltbld', 05:52:08 INFO - 'LANG': 'en_US.UTF-8', 05:52:08 INFO - 'LANGUAGE': 'en_US:en', 05:52:08 INFO - 'LOGNAME': 'cltbld', 05:52:08 INFO - 'MAIL': '/var/mail/cltbld', 05:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:08 INFO - 'MOZ_NO_REMOTE': '1', 05:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:08 INFO - 'NO_EM_RESTART': '1', 05:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:08 INFO - 'PWD': '/builds/slave/test', 05:52:08 INFO - 'SHELL': '/bin/bash', 05:52:08 INFO - 'SHLVL': '1', 05:52:08 INFO - 'TERM': 'linux', 05:52:08 INFO - 'TMOUT': '86400', 05:52:08 INFO - 'USER': 'cltbld', 05:52:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', 05:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:08 INFO - '_': '/tools/buildbot/bin/python'} 05:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:08 INFO - Running setup.py (path:/tmp/pip-KzQsee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:08 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)) 05:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:08 INFO - Running setup.py (path:/tmp/pip-92YHsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:08 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)) 05:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:08 INFO - Running setup.py (path:/tmp/pip-59x56t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:08 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)) 05:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:08 INFO - Running setup.py (path:/tmp/pip-BTutWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:08 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)) 05:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:08 INFO - Running setup.py (path:/tmp/pip-dxYij2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:08 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)) 05:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:08 INFO - Running setup.py (path:/tmp/pip-6f489Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:08 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)) 05:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:08 INFO - Running setup.py (path:/tmp/pip-FXqq6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:09 INFO - Running setup.py (path:/tmp/pip-Cr6pbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:09 INFO - Running setup.py (path:/tmp/pip-u363fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:09 INFO - Running setup.py (path:/tmp/pip-7NJ6Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:09 INFO - Running setup.py (path:/tmp/pip-zBFixR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:09 INFO - Running setup.py (path:/tmp/pip-fhmjjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:09 INFO - Running setup.py (path:/tmp/pip-RhmUn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:09 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)) 05:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:09 INFO - Running setup.py (path:/tmp/pip-ZQS7f0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:09 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)) 05:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:09 INFO - Running setup.py (path:/tmp/pip-D4wsVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:09 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)) 05:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:09 INFO - Running setup.py (path:/tmp/pip-FDdN7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:09 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)) 05:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:09 INFO - Running setup.py (path:/tmp/pip-ZFdxdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:09 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)) 05:52:09 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)) 05:52:09 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)) 05:52:09 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)) 05:52:09 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)) 05:52:09 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)) 05:52:09 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)) 05:52:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:52:09 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 05:52:09 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 05:52:09 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 05:52:09 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 05:52:10 INFO - Downloading blessings-1.6.tar.gz 05:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:52:10 INFO - Installing collected packages: blessings 05:52:10 INFO - Running setup.py install for blessings 05:52:11 INFO - Successfully installed blessings 05:52:11 INFO - Cleaning up... 05:52:11 INFO - Return code: 0 05:52:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:52:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:11 INFO - Reading from file tmpfile_stdout 05:52:11 INFO - Current package versions: 05:52:11 INFO - argparse == 1.2.1 05:52:11 INFO - blessings == 1.6 05:52:11 INFO - blobuploader == 1.2.4 05:52:11 INFO - docopt == 0.6.1 05:52:11 INFO - functools32 == 3.2.3-2 05:52:11 INFO - jsonschema == 2.5.1 05:52:11 INFO - manifestparser == 1.1 05:52:11 INFO - mozInstall == 1.13 05:52:11 INFO - mozcrash == 1.0 05:52:11 INFO - mozdebug == 0.1 05:52:11 INFO - mozdevice == 0.51 05:52:11 INFO - mozfile == 1.2 05:52:11 INFO - mozhttpd == 0.7 05:52:11 INFO - mozinfo == 0.10 05:52:11 INFO - mozleak == 0.1 05:52:11 INFO - mozlog == 3.5 05:52:11 INFO - moznetwork == 0.27 05:52:11 INFO - mozprocess == 0.25 05:52:11 INFO - mozprofile == 0.28 05:52:11 INFO - mozrunner == 6.13 05:52:11 INFO - mozscreenshot == 0.1 05:52:11 INFO - mozsystemmonitor == 0.3 05:52:11 INFO - moztest == 0.8 05:52:11 INFO - mozversion == 1.4 05:52:11 INFO - psutil == 3.1.1 05:52:11 INFO - requests == 1.2.3 05:52:11 INFO - wsgiref == 0.1.2 05:52:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194f090>, '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 0x194fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', '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 05:52:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:52:11 INFO - Using env: {'DISPLAY': ':0', 05:52:11 INFO - 'HOME': '/home/cltbld', 05:52:11 INFO - 'LANG': 'en_US.UTF-8', 05:52:11 INFO - 'LANGUAGE': 'en_US:en', 05:52:11 INFO - 'LOGNAME': 'cltbld', 05:52:11 INFO - 'MAIL': '/var/mail/cltbld', 05:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:11 INFO - 'MOZ_NO_REMOTE': '1', 05:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:11 INFO - 'NO_EM_RESTART': '1', 05:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:11 INFO - 'PWD': '/builds/slave/test', 05:52:11 INFO - 'SHELL': '/bin/bash', 05:52:11 INFO - 'SHLVL': '1', 05:52:11 INFO - 'TERM': 'linux', 05:52:11 INFO - 'TMOUT': '86400', 05:52:11 INFO - 'USER': 'cltbld', 05:52:11 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', 05:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:11 INFO - '_': '/tools/buildbot/bin/python'} 05:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:11 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)) 05:52:11 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)) 05:52:11 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)) 05:52:11 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)) 05:52:11 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)) 05:52:11 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)) 05:52:11 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)) 05:52:11 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)) 05:52:11 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)) 05:52:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:52:11 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 05:52:11 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 05:52:11 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 05:52:11 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 05:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:52:12 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)) 05:52:12 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)) 05:52:12 INFO - Installing collected packages: simplejson 05:52:12 INFO - Running setup.py install for simplejson 05:52:13 INFO - building 'simplejson._speedups' extension 05:52:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 05:52:13 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 05:52:13 INFO - Successfully installed simplejson 05:52:13 INFO - Cleaning up... 05:52:13 INFO - Return code: 0 05:52:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:52:13 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')]} 05:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:13 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')]} 05:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:13 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 0x15df1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x194ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194f090>, '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 0x194fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949f90>, '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': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', '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 05:52:13 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 05:52:13 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 05:52:13 INFO - Using env: {'DISPLAY': ':0', 05:52:13 INFO - 'HOME': '/home/cltbld', 05:52:13 INFO - 'LANG': 'en_US.UTF-8', 05:52:13 INFO - 'LANGUAGE': 'en_US:en', 05:52:13 INFO - 'LOGNAME': 'cltbld', 05:52:13 INFO - 'MAIL': '/var/mail/cltbld', 05:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:13 INFO - 'MOZ_NO_REMOTE': '1', 05:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:13 INFO - 'NO_EM_RESTART': '1', 05:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:13 INFO - 'PWD': '/builds/slave/test', 05:52:13 INFO - 'SHELL': '/bin/bash', 05:52:13 INFO - 'SHLVL': '1', 05:52:13 INFO - 'TERM': 'linux', 05:52:13 INFO - 'TMOUT': '86400', 05:52:13 INFO - 'USER': 'cltbld', 05:52:13 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', 05:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:14 INFO - '_': '/tools/buildbot/bin/python'} 05:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:52:14 INFO - Cleaning up... 05:52:14 INFO - Return code: 0 05:52:14 INFO - Running post-action listener: _resource_record_post_action 05:52:14 INFO - Running post-action listener: _start_resource_monitoring 05:52:14 INFO - Starting resource monitoring. 05:52:14 INFO - [mozharness: 2017-09-13 12:52:14.256292Z] Finished create-virtualenv step (success) 05:52:14 INFO - [mozharness: 2017-09-13 12:52:14.257238Z] Running install step. 05:52:14 INFO - Running pre-action listener: _resource_record_pre_action 05:52:14 INFO - Running main action method: install 05:52:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:14 INFO - Reading from file tmpfile_stdout 05:52:14 INFO - Detecting whether we're running mozinstall >=1.0... 05:52:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:52:14 INFO - Reading from file tmpfile_stdout 05:52:14 INFO - Output received: 05:52:14 INFO - Usage: mozinstall [options] installer 05:52:14 INFO - Options: 05:52:14 INFO - -h, --help show this help message and exit 05:52:14 INFO - -d DEST, --destination=DEST 05:52:14 INFO - Directory to install application into. [default: 05:52:14 INFO - "/builds/slave/test"] 05:52:14 INFO - --app=APP Application being installed. [default: firefox] 05:52:14 INFO - mkdir: /builds/slave/test/build/application 05:52:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:52:32 INFO - Reading from file tmpfile_stdout 05:52:32 INFO - Output received: 05:52:32 INFO - /builds/slave/test/build/application/firefox/firefox 05:52:32 INFO - Running post-action listener: _resource_record_post_action 05:52:32 INFO - [mozharness: 2017-09-13 12:52:32.169400Z] Finished install step (success) 05:52:32 INFO - [mozharness: 2017-09-13 12:52:32.169545Z] Running setup-mitmproxy step. 05:52:32 INFO - Running pre-action listener: _resource_record_pre_action 05:52:32 INFO - Running main action method: setup_mitmproxy 05:52:32 INFO - Skipping: mitmproxy is not required 05:52:32 INFO - Running post-action listener: _resource_record_post_action 05:52:32 INFO - [mozharness: 2017-09-13 12:52:32.170074Z] Finished setup-mitmproxy step (success) 05:52:32 INFO - [mozharness: 2017-09-13 12:52:32.170177Z] Running run-tests step. 05:52:32 INFO - Running pre-action listener: _resource_record_pre_action 05:52:32 INFO - Running pre-action listener: _set_gcov_prefix 05:52:32 INFO - Running main action method: run_tests 05:52:32 WARNING - Try message not found. 05:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:52:32 INFO - Python 2.7.3 05:52:32 INFO - Return code: 0 05:52:32 INFO - grabbing minidump binary from tooltool 05:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194f090>, '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 0x194fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1949f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:52:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:52:32 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:52:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:52:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:52:32 INFO - Return code: 0 05:52:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:52:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:52:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:52:32 INFO - ENV: RUST_BACKTRACE is now full 05:52:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:52:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 05:52:32 INFO - Using env: {'DISPLAY': ':0', 05:52:32 INFO - 'HOME': '/home/cltbld', 05:52:32 INFO - 'LANG': 'en_US.UTF-8', 05:52:32 INFO - 'LANGUAGE': 'en_US:en', 05:52:32 INFO - 'LOGNAME': 'cltbld', 05:52:32 INFO - 'MAIL': '/var/mail/cltbld', 05:52:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:52:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:32 INFO - 'MOZ_NO_REMOTE': '1', 05:52:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:32 INFO - 'NO_EM_RESTART': '1', 05:52:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:32 INFO - 'PWD': '/builds/slave/test', 05:52:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:52:32 INFO - 'RUST_BACKTRACE': 'full', 05:52:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:52:32 INFO - 'SHELL': '/bin/bash', 05:52:32 INFO - 'SHLVL': '1', 05:52:32 INFO - 'TERM': 'linux', 05:52:32 INFO - 'TMOUT': '86400', 05:52:32 INFO - 'USER': 'cltbld', 05:52:32 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', 05:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:32 INFO - '_': '/tools/buildbot/bin/python'} 05:52:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:52:32 INFO - mozversion application_buildid: 20170913113324 05:52:32 INFO - mozversion application_changeset: 1888ec2f277f6bb26271b8808e08914a21db9efe 05:52:32 INFO - mozversion application_display_name: Nightly 05:52:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:52:32 INFO - mozversion application_name: Firefox 05:52:32 INFO - mozversion application_remotingname: firefox 05:52:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:52:32 INFO - mozversion application_vendor: Mozilla 05:52:32 INFO - mozversion application_version: 57.0a1 05:52:32 INFO - mozversion platform_buildid: 20170913113324 05:52:32 INFO - mozversion platform_changeset: 1888ec2f277f6bb26271b8808e08914a21db9efe 05:52:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:52:32 INFO - mozversion platform_version: 57.0a1 05:52:32 INFO - using testdate: 1505307152 05:52:32 INFO - actual date: 1505307152 05:52:32 INFO - starting webserver on 'localhost:59209' 05:52:32 INFO - SUITE-START | Running 2 tests 05:52:32 INFO - TEST-START | dromaeo_css 05:52:32 INFO - Initialising browser for dromaeo_css test... 05:52:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59209/getInfo.html -profile /tmp/tmpygMcRE/profile 05:52:32 INFO - TEST-INFO | started process 3600 (/builds/slave/test/build/application/firefox/firefox http://localhost:59209/getInfo.html) 05:52:41 INFO - TEST-INFO | 3600: exit 0 05:52:41 INFO - Browser initialized. 05:52:41 INFO - Running cycle 1/1 for dromaeo_css test... 05:52:41 INFO - Using env: {'DISPLAY': ':0', 05:52:41 INFO - 'HOME': '/home/cltbld', 05:52:41 INFO - 'JSGC_DISABLE_POISONING': '1', 05:52:41 INFO - 'LANG': 'en_US.UTF-8', 05:52:41 INFO - 'LANGUAGE': 'en_US:en', 05:52:41 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:52:41 INFO - 'LOGNAME': 'cltbld', 05:52:41 INFO - 'MAIL': '/var/mail/cltbld', 05:52:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:52:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:52:41 INFO - 'MOZ_CRASHREPORTER': '1', 05:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:41 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:52:41 INFO - 'MOZ_NO_REMOTE': '1', 05:52:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:41 INFO - 'NO_EM_RESTART': '1', 05:52:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:41 INFO - 'PWD': '/builds/slave/test', 05:52:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:52:41 INFO - 'RUST_BACKTRACE': 'full', 05:52:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:52:41 INFO - 'SHELL': '/bin/bash', 05:52:41 INFO - 'SHLVL': '1', 05:52:41 INFO - 'STYLO_FORCE_DISABLED': '1', 05:52:41 INFO - 'TERM': 'linux', 05:52:41 INFO - 'TMOUT': '86400', 05:52:41 INFO - 'USER': 'cltbld', 05:52:41 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', 05:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:41 INFO - '_': '/tools/buildbot/bin/python'} 05:52:41 INFO - TEST-INFO | started process 3788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpygMcRE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:42 INFO - PID 3788 | 05:52:42 INFO - PID 3788 | (/builds/slave/test/build/application/firefox/firefox:3838): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:52:42 INFO - PID 3788 | 05:52:52 INFO - PID 3788 | RSS: Main: 167129088 05:52:52 INFO - PID 3788 | 05:55:49 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:59209/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59209/tests/dromaeo/cssquery-ext.html) 05:55:50 INFO - PID 3788 | RSS: Main: 169488384 05:55:50 INFO - PID 3788 | 05:58:52 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:59209/tests/dromaeo/cssquery-ext.html (next: http://localhost:59209/tests/dromaeo/cssquery-jquery.html) 05:58:53 INFO - PID 3788 | RSS: Main: 165376000 05:58:53 INFO - PID 3788 | 06:01:54 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:59209/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59209/tests/dromaeo/cssquery-mootools.html) 06:01:55 INFO - PID 3788 | RSS: Main: 168001536 06:01:55 INFO - PID 3788 | 06:04:56 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:59209/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59209/tests/dromaeo/cssquery-prototype.html) 06:04:57 INFO - PID 3788 | RSS: Main: 165130240 06:04:57 INFO - PID 3788 | 06:08:00 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:59209/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59209/tests/dromaeo/cssquery-yui.html) 06:08:01 INFO - PID 3788 | RSS: Main: 168505344 06:08:01 INFO - PID 3788 | 06:11:02 INFO - PID 3788 | Cycle 1(1): loaded http://localhost:59209/tests/dromaeo/cssquery-yui.html (next: http://localhost:59209/tests/dromaeo/cssquery-dojo.html) 06:11:02 INFO - PID 3788 | RSS: Main: 170999808 06:11:02 INFO - PID 3788 | 06:11:02 INFO - PID 3788 | __start_tp_report 06:11:02 INFO - PID 3788 | _x_x_mozilla_page_load 06:11:02 INFO - PID 3788 | _x_x_mozilla_page_load_details 06:11:02 INFO - PID 3788 | |i|pagename|runs| 06:11:02 INFO - PID 3788 | |0;dojo.html;3895.065184355755;3898.785566793825;3917.4907262055945;3927.783971881547;3935.8032098395083;6277.748890044393;6294.213223347082;6349.269833969095;6379.13881625981;6426.614403135815;6342.714577843996;6385.138006369139;6416.4225219730215;6419.165508483902;6483.416492515673;5652.180433837091;5746.597738158331;5773.30720313563;5796.884062318751;5810.418958104198;123.46302701277385;5718.142278658193;5765.740541675635;5811.331696854852;5823.097419899901;5294.973525132369;5585.832425027255;5673.432656734314;5768.97115514424;5782.653040817564;5687.317521897398;5695.857603559903;5707;5714.257146570919;5740.856478588027;5666.433356664342;5685.431456854281;5689.971550142264;5694.316681998145;5701.4298570142655;6315.873682526324;6395.616263024233;6423.93576064238;6439.420452159328;6460.676966151674;6809.795706128824;6823.078884350599;6913.827154321182;6931.41083007945;6987.510874238806;6786.287439818797;6918.481113916426;6924.58452492847;6926.099607051102;7025.648717564152;6345.809625711236;6356.046593011085;6356.364363563653;6356.586821856565;6384.968075159641;7050.964745176241;7084.645767711594;7111.679974401164;7124.92875071253;7206.2793720627515;6823.590584564942;6824.965875170592;6901.551399159039;6912.343327383891;6916.792496225121;6815.795526134224;6922.5154239202775;6970.372666459942;7023.8595228095155;7036.577805331696;6834;6861.588304701734;6885.036094946711;6896.379325860697;6906.965465172742;6833.555818871758;6898.172219333712;6902.689378977958;6930.410915072174;6951.131108611424;5008.949910500921;5035.018171456604;5081.644284900021;5086.567641750418;5087.796488140507;4509.075639493962;4512.548745125527;4537.77311134442;4552.044070745181;4561.1333846569705;6362.968185159137;6373;6378.45783108441;6389;6407.487401007908;6831.04365388846;6923.446124310043;6933.064036355128;6935.133108361455;6938.895916561256;6310.495160387158;6311.495080393557;6316.336784637639;6390.904136437957;6405.935940640534;5484.149956756709;5513.558915286768;5520.558355331564;5546.722663866791;5591.3569939456665;7140.357367836919;7166.605836679033;7170.067891174114;7174.964125179341;7180.820479488055;6685.966570167118;6843.555168914005;6862;6875.656217189021;6942.51402401827;7113.502054856111;7218.639068046472;7221.747238846615;7227.421806255592;7257.891131632924;6758.986152077031;6821.624810635462;6845;6936.7225310989015;6943.861122777617;6836.555623884432;6931.826704332432;6964.547304425196;7009.439244860501;7019.438444924496;6616.437602803816;6636.83407914806;6683.131192944886;6689.76585819494;6689.933100668931;6555.541112122106;6567.507436942344;6747.089142965637;6751.088603038724;6752.08846805675;6567.802965910839;6574.934250657623;6664.50016248793;6666.100076489612;6666.566673166229;6569.24453687832;6648.966755166193;6660.766873159416;6695.230048544479;6786.898196527155;6459.967700161657;6490.675466226764;6523.3150519194805;6527.5430719849155;6548.345165483413 06:11:02 INFO - PID 3788 | |1;ext.html;959.908808663177;981.2542467724527;986.5511192407455;995.2336700740426;1001.6043662753212;44694.329585056206;45546;45601.08797824046;45634.543654563524;45777.77111114448;42105.78947105268;42287.78856105723;42288.365674514906;42464;42611.14777704444;7455.813604659873;7514.6618402172035;7565.659545320446;7569.243075692441;7569.280918312751;7415.1843297237265;7467.9626601867185;7479.663415146331;7487.925120748804;7493.063367079088;7777.727779527718;7902.170272121431;7906.960465197666;7910;7917.722879699211;7772.494787838772;7801.648925798353;7866.1347251802545;7868.842623147533;8019.438639295252;8000.63997120131;8076.717314894009;8077.676892924276;8079.353651707849;8086.555239461827;41606;41926.1614767706;41931;42122.57877421248;42124;3737.2338670572467;3769.3403654360377;3775.4903088083033;3788.1666033472593;3798.2403519295976;33595.496067559005;33659.6634033659;33727.32545349079;33757.83121084404;33800.83099584511;5585.776568937237;5589.049861523551;5631.042722737145;5634.098544232903;5734.369219385864;210881.9455902726;213043;213911;213951;214554;46420.535794642296;53412.46587534075;53893.461065388845;53922.730386347816;54036.729816350664;57834.7108264456;57950;57978.8404231913;58051.4194858046;58079;17159.399421020204;17323.56691082733;17326.393576225022;17338;17341.479755607354;14481.710365792625;14505.274736263145;14506.347214375379;14508.85491145075;14511.1293322401;15204.695906081817;15209.771853422208;15236.466723664618;15414;15444.150571718663;5877.353491115974;5964.314103878023;5978.760849566055;6162.630242185483;6193.907091393633;1115.537052123376;1119.4011204005817;1128.3568366031448;1129.412705393191;1137.766757814646;25589.104381346562;25615.23154305374;25701.614475782877;25896.964121435307;26064.60903086455;1220.6094049904123;1238.7584421037811;1251.380566619511;1254.6737848159544;1257.1953949472345;13253.801192982113;13499.257540835348;13543.119697219649;13670.453181872614;13748.312584370742;256703;259566;260243;260258;261193;57742.7112864433;57773.711131444914;57953;58263.70868145717;58402.7079864598;1522.3453914816514;1528.6636939873433;1558.9376424942875;1564.5932057665088;1592.6416556274978;25152.24543263705;25174;25360.239192824243;25547.6167857486;25626.615600766378;41643.37534937039;41651;41687;41798.791006044776;41808.37287440752;229749;230031;230303;231059;231155;36800.07999800026;42806;42964;43232.56767432411;43270;52768.472315276354;52825;52922.73538632282;53165;53189.468105318454;38420.84737457881;38497;38900.80549597234;38957.02607434837;38995.610043900335;38245;38523.22953540969;38565.80717096396;38724;38784.418233725955;44491.66882328335;44539;44645.330320045876;44693.77653111714;44798.328025079;36962.26075478529;37066.8146659265;37313.813430933755;37529.81235093807;37584.812075939444;27513.587296190173;27916.44167116687;28111.297217568906;28160.130523886466;28176.29559261035 06:11:02 INFO - PID 3788 | |2;jquery.html;582.2285471749927;591.8549955260962;597.6025942748073;603.1194456094103;603.8611119442528;23625.52748945022;24339.756602433972;24360;24373;24397.3900652484;25327;25864.35339116523;26849.73150268497;27033;27168.32079198021;6696.665166741655;6875.931240687579;6891.896621550681;6899.689513971858;6900.137482814648;6421.7752378666755;6665.966670166642;6693.464522838186;6700.363465470772;6803.965980170092;6658.467322614203;6658.933410665904;6662.800115996528;6666.699998500079;6669.43309818666;6614.305497922745;6654.4676425886055;6656.400923916846;6658.434033107167;6879.105716256855;6366.77716279928;6386.201724784402;6437.935620643827;6442.065900444456;6442.871142577169;30279;30652;30708.232294192825;30737.38525229483;30793.230169245948;2298.0463107810237;2323.0939933425807;2323.163661082009;2323.1984965187153;2328.6739856420113;20421.28525501615;20880;21246.787532124636;21401.785982140136;21439.249626263005;2486.0677246032737;2512.57286261336;2548.9107881224254;2587.3143616941525;2590.5984572391308;138940;145230.27384863008;154577.22711386372;160654;160904.19547902304;15383.846161538242;15969.201539922957;15977.360905563879;16035.43875964359;16789.24448399825;26184.8690756545;26327.34181645474;26404.60393094105;26408.339791505365;26413.07554235631;10669.786604268027;10886.455677216107;10921.945390273157;10991.175661825395;11076;10072.345297555636;10073.395596264247;10186.847197292047;10194.28639995208;10204.591816327413;9783.951080244553;9872.654457093968;9877.851832222523;9905.80188396228;9993.700188994342;2741.2050505353222;2798.3284011837013;2846.6014757933904;2864.8854045838348;2905.259158914463;1016.6289304403987;1027.3271007489957;1030.5517100061497;1030.567161792049;1049.4070849969742;20783.168673253203;21019.68470472944;21039.579208416053;21181.258655946967;21211.257605983716;1093.1091160704;1099.4173088263233;1102.691246450995;1105.3312745788842;1108.6563165418745;11422;11825.408729563487;11859.347735874437;11996.820047699292;12036.338001410006;622098;642079;646846;649735;652981;127555;132371;135678;136224.31887840497;136780.31609841887;1117.9385133817718;1172.5485688010008;1226.2458587968335;1226.7607816475702;1291.520281060385;22856.885715571316;22979.88510057439;23063.654045189673;23210.65184022275;23462.530749384576;62461.375386245556;62742.68628656828;63685.68157159184;64286.67856660687;64840.675796620715;78080.2191978073;79755.20244797478;79760;80331.59834200791;80897;15669.294881730577;15835.366585336458;15962.441314553935;16068.35726570924;16082.35670573164;22814.771852281265;22904.427389315402;24679.136230231856;25031.249062528153;25327.873360633817;18935.526611834815;19128.71306930425;20264;20613.484662883548;20619;17412.47762567125;17712.46862594124;17921.641567168324;18361.173747181143;18441.815581844545;18912.621747564695;20568.382948511568;20706.792932070486;20827.58344833125;20899.8955005224;15682.294296756445;15751.68496630084;15767.68464630678;15799.131047792482;15799.21003949821;17739.290428383236;18448.907755461136;19990.20039198416;20011.899940500203;20251 06:11:02 INFO - PID 3788 | |3;mootools.html;1404.9297535123244;1456.140876882639;1476.7341878461875;1480.84451132631;1487.888408369372;16524;17189.656206875854;17211;17244.655106897855;17245;16804.075775832323;16895.408660696878;16946.745798813026;16982.320707171697;16986.235619397125;2581.5740402833558;2729.6314997475383;2739.5479745842013;2741.575055866334;2752.545829938058;2712.715164907686;2722.169738229839;2773.778097752175;2778.8749506272165;2781.7913656475844;2797.314657908815;2839.3895312507807;2841.9857900710467;2842.2183899427614;2856.157433557106;2701.0951331304036;2735.685396179445;2743.341598016482;2744.4511097780523;2751.9862400688066;2664;2695.258803828943;2702.8783704733137;2702.9189124326303;2705.499482595726;16387.83612163887;16712.49862504127;16719.331226750914;16721.916390418093;16746.748798767905;8375.329973602098;8645.52449615271;8646.048934617187;8678.132186781335;8681.262092722063;5233.371995360543;5364.383095943977;5544.0575102232315;5551.528120109796;5575.163725441216;2053.671412573981;2071.54426026274;2071.616750901073;2138.240924471821;2145.903434345458;29909.401811963857;30297.545536816964;30327;30349.848250758605;31060.689393106004;7222.53053551528;7224.783256502314;7276.7816965490065;7362.153352364439;7423.62881855905;19557.51106222356;19583.510412239808;19583.804161958484;19586.118624661925;19602.215911363386;8365.95817020911;8579;8585.441946273471;8622.180892815173;8625.223729864218;7910.288074073361;7914.802129946797;7955.24425179607;7984.481008734414;7989.680412783539;5569.220309156722;5730.426957304319;5731.108734117731;5785.566082543826;5826.592138550345;1590.1651632892824;1630.5760502269259;1655.6771429571118;1665.6918470083074;1685.7050016247108;945.1682519382899;953.1421720451649;956.9473678947725;967.0957654592978;968.0174622757906;8325.458845175044;8330.458520196167;8353;8457.788555286166;8477.703280385156;769.1270408086862;782.3115658220729;787.582581231948;788.8067423481169;800.6957356204605;4696.671233013724;5261.868453288698;5671.886562268732;5690.231818704422;5747.597668163272;24257.87871060669;24767.38081547976;24826.255212343298;24830.37924051913;25361.365965851;24775.876120619283;24784.5043099137;24865;25029.62455563168;25098.74901250964;12124.696882578006;12545.247285162919;12683;12745.808812867814;12772.744545109046;8506.74479765608;8571.442856214326;8724.825503490021;8759.868601970848;8857;20990.895045524674;21939.451513712283;22119.115235390404;22237.332880013626;22579.43551411228;21650.35048948534;21938.232161874257;22033.33899983003;22096.2266320678;22339.553208936057;11755.88244117548;11856.051515878882;11928.045756339645;11942.223755455867;11942.343171125323;15265.847341526443;15297.388104475696;15304.693906121593;15319.617009574404;15334.9233253833;12102.09234307448;12221.083418743807;12224.44989975471;12284.508619655113;12535;11928.582499612472;12181.75636487283;12194.57318993831;12239.571614993432;12348.197367171106;10292.845607316047;10328.070473657406;10381.792364152825;10427.530761115617;10555.41945192991;7370.889436658347;7424.257574242532;7529.435292353205;7548.1697013329585;7624;7354.70581176747;7487.363574096045;7492.587907664913;7522.210167932507;7612.80967975805 06:11:02 INFO - PID 3788 | |4;prototype.html;539.1885212754801;544.9182622606609;556.6326224691704;567.5147748674881;584.7485581200085;6244.782267457842;6266.1540692006565;6294.307626161119;6303.054541818724;6314.116023756677;6140.600860944036;6177;6183.443490085902;6241.282252540959;6242;5008.223725322581;5061.848144555669;5079.593632509391;5080.59355251579;5100.225832883676;4978.452370239271;4990.101781679296;4994.175960966436;5038.697678139305;5048.368953880765;4796.640251981098;4882.2432522958825;4915.361003069596;5011.749412529359;5017.949820501803;4877.292792545079;4899.853004409855;4903.583195428393;4919.360483137205;4938.80244790208;4341.826326946918;4429.379886815848;4438.7114837535455;4449.288113901793;4473.105378924228;5966.791162309299;6029.155918171459;6047.395260473962;6087.269527656666;6094.299155597118;5692.117721753135;5732.484076433099;5758.74085666146;5793.725380416302;5804.2744656917885;6537.803865884031;6548.967255163694;6580.736770529173;6606.570572912745;6615.503837212228;4947.604191664658;5007.799688012475;5019.698818070928;5024.9748751256375;5036.11867923112;6610.8016759497295;6620.702068406933;6792.76225332111;6852.45180385573;6919.719851827378;5072.213806859942;5099.643024988215;5108.66793658411;5143.382794064736;5154.252633368215;5193.792248310101;5210.088234558937;5218.66078704883;5228.738563071907;5229.816956406507;5735.11105778605;5749.8562535936935;5773.902958437883;5795.1017592273265;5802.33273173582;6391.3289104643345;6422.165118534561;6440.710168042449;6531.118299029666;6573.835654108686;1762.8149044350414;1796.8203179681927;1796.9281228750965;1797.703378942486;1808.1592059692307;1230.2887747338427;1277.7636137314626;1281.705207802192;1289.9742005159844;1294.7151626642124;5940.34656187819;5958.731857066442;5988.520918326523;6044.365341639153;6129.448349648553;6512.5441219115155;6553.263385202925;6557.180352455943;6622.503312251504;6724.7646332378135;5915.940840591539;6009.188759517497;6047.879042419215;6054.485368743618;6105.877882442326;3438.9312213755584;3493.3886569850174;3494.790312581253;3512.7892326459983;3533.982330088333;6936.79189624312;6972.337627925339;6996.475264355194;6998.16022077354;7003.4747393944635;6811.284815094344;6874.415674667609;6897.379235868796;6942.1669399671355;6972.744905916882;6793.660316984131;6815.863682726318;6837.35045170708;6883.7590684325805;6914.757983470555;6593.80218593443;6597.934020659732;6676;6703.530752847254;6731.418116742464;6531.836704082436;6579.769708060387;6594.769183078569;6619.602823830585;6704.318272690768;6807.21717002551;6914.4468442525485;6927.3419025192525;6980.720771169096;6981.301869812978;5082.33929589151;5134.845954621367;5149.279100925948;5154.768035438339;5183.3261675983385;6479.732093767144;6538.411542961157;6598.868022639616;6733;6745;6386.201724784402;6399;6445.806625801233;6487.3188315226225;6496.805095847132;6357.650329231752;6434.581752186093;6437.291897891135;6457.160569125984;6458.418742313214;6315;6334.398232167937;6343.777967771106;6421.903671444838;6423.132877061536;6473.417392434703;6474.471413079788;6481.611103333815;6521.054447105048;6541.901871471837;6282.308946016026;6340.778072767431;6347.428731414195;6363.61818290904;6423.646699431576 06:11:02 INFO - PID 3788 | |5;yui.html;942.888468055417;986.9950650246748;989.2333441582772;997.1225321716893;1018.7605912610535;19529.414117576478;20036.59926801463;20060.097295621676;20062.59874802503;20223.98880055995;18667.533311667215;19104.713429298536;19146.617067658637;19193.999999999964;19201.231950721954;1061.3790932304591;1084.0893649334557;1084.511969613673;1084.6908631040155;1087.0434018064132;1045.2474218562622;1060.6499855047816;1060.931039482435;1071.4214324264926;1074.2319241742152;1126.5043380912373;1131.1007748839693;1137.3744440557703;1137.419915842922;1139.0887290167875;1073.8603981482436;1104.6962085426571;1125.038092430972;1126.8140756775163;1127.9041281491084;810.4610434061342;820.1839170025803;820.7619790260817;821.843849668561;822.7901885019342;19444.611107777906;19725.11236994339;19775.703364449546;19793;19800.108995095256;21704.56590868174;22251.888740556355;22554.097836086537;22569.210077647203;22618.434539136488;18319.633607327913;18342.174602142935;18439.72340414895;18477.353292634692;18530.444086677286;4032.7378720383376;4060.5330387005283;4063.674906007512;4078.6737061035046;4082.387641853716;151344;152107;152753;154173.99999999886;155836;16746.91626541884;16863;16937.830621693873;17122.914385427994;17172.914135429244;32447.837760811046;32503.18742031468;32553;32729.34541309208;32771.50842737313;8276.917230827736;8454.070052294242;8533.914660853436;8559;8559.572021398904;4218.430511880918;4278.957210427918;4282.807273672693;4314.590113939171;4317.309230523101;6082.513398928075;6103.328633850273;6115.541334399938;6186.041163619646;6226.813195604139;1121.7083558274908;1147.3173461790389;1150.4535345710888;1156.8611766588062;1160.2980196980873;684.1619016704498;697.0659316515893;705.7036044861171;708.3235510087853;710.8294009437698;11108.500117494732;11478.655640330804;11801.29192248468;12079.51681932713;12334.259944403364;663.4559661077869;680.8740383029156;685.6640246279287;689.9275576064441;693.1612748574181;5402;5407.215953686772;5535.6955367455175;5588.189712491666;5602.719864006865;150136;151886;154457;154894;156810;104294;128118.35940820236;130056;132482;139364;113998.43000784943;114199.42900285445;115566.42216788694;117805;117923.41038294754;12495.25028498293;13040.282784446947;13136.868631313564;13143.408546615234;13169.946404287442;55625;56793;57001.71499142478;57340.71329643492;57466.13800793075;69975.65012174906;72703.27296726964;73375.26624733684;73553;74356;18217.362392316205;18499.260029598667;18591.72112418342;18598.53503662419;18735.531611709815;18934.905325473286;18987.810121898605;19017.904910475358;19061.332853350064;19122.235110595422;17492.300307988047;17721.645567088843;17804.91097544504;17935;17971.37100201487;16272.593185170466;16357.918210408872;16488;16537;16537.255823488213;16779.74830377521;16958.406455773988;16986.74519882178;17014.659706805545;17102.315907363565;12589.559365422167;12711.110222284351;12795.552155674506;12813.295268760308;13185.53850615224;11894.643160704847;11960.401979900797;12145.817812732992;12231.633051008484;12368.75262494763 06:11:02 INFO - PID 3788 | __end_tp_report 06:11:02 INFO - PID 3788 | __start_cc_report 06:11:02 INFO - PID 3788 | _x_x_mozilla_cycle_collect,391 06:11:02 INFO - PID 3788 | __end_cc_report 06:11:02 INFO - PID 3788 | __startTimestamp1505308262920__endTimestamp 06:11:02 INFO - PID 3788 | 06:11:02 INFO - PID 3788 | ------- Summary: start ------- 06:11:02 INFO - PID 3788 | Number of tests: 6 06:11:02 INFO - PID 3788 | 06:11:02 INFO - PID 3788 | [#0] dojo.html Cycles:165 Average:6313.30 Median:6567.80 stddev:904.00 (13.8%) stddev-sans-first:886.64 06:11:02 INFO - PID 3788 | Values: 3895.1 3898.8 3917.5 3927.8 3935.8 6277.7 6294.2 6349.3 6379.1 6426.6 6342.7 6385.1 6416.4 6419.2 6483.4 5652.2 5746.6 5773.3 5796.9 5810.4 123.5 5718.1 5765.7 5811.3 5823.1 5295.0 5585.8 5673.4 5769.0 5782.7 5687.3 5695.9 5707.0 5714.3 5740.9 5666.4 5685.4 5690.0 5694.3 5701.4 6315.9 6395.6 6423.9 6439.4 6460.7 6809.8 6823.1 6913.8 6931.4 6987.5 6786.3 6918.5 6924.6 6926.1 7025.6 6345.8 6356.0 6356.4 6356.6 6385.0 7051.0 7084.6 7111.7 7124.9 7206.3 6823.6 6825.0 6901.6 6912.3 6916.8 6815.8 6922.5 6970.4 7023.9 7036.6 6834.0 6861.6 6885.0 6896.4 6907.0 6833.6 6898.2 6902.7 6930.4 6951.1 5008.9 5035.0 5081.6 5086.6 5087.8 4509.1 4512.5 4537.8 4552.0 4561.1 6363.0 6373.0 6378.5 6389.0 6407.5 6831.0 6923.4 6933.1 6935.1 6938.9 6310.5 6311.5 6316.3 6390.9 6405.9 5484.1 5513.6 5520.6 5546.7 5591.4 7140.4 7166.6 7170.1 7175.0 7180.8 6686.0 6843.6 6862.0 6875.7 6942.5 7113.5 7218.6 7221.7 7227.4 7257.9 6759.0 6821.6 6845.0 6936.7 6943.9 6836.6 6931.8 6964.5 7009.4 7019.4 6616.4 6636.8 6683.1 6689.8 6689.9 6555.5 6567.5 6747.1 6751.1 6752.1 6567.8 6574.9 6664.5 6666.1 6666.6 6569.2 6649.0 6660.8 6695.2 6786.9 6460.0 6490.7 6523.3 6527.5 6548.3 06:11:02 INFO - PID 3788 | 06:11:02 INFO - PID 3788 | [#1] ext.html Cycles:180 Average:42494.61 Median:38976.32 stddev:61018.54 (156.6%) stddev-sans-first:61110.01 06:11:02 INFO - PID 3788 | Values: 959.9 981.3 986.6 995.2 1001.6 44694.3 45546.0 45601.1 45634.5 45777.8 42105.8 42287.8 42288.4 42464.0 42611.1 7455.8 7514.7 7565.7 7569.2 7569.3 7415.2 7468.0 7479.7 7487.9 7493.1 7777.7 7902.2 7907.0 7910.0 7917.7 7772.5 7801.6 7866.1 7868.8 8019.4 8000.6 8076.7 8077.7 8079.4 8086.6 41606.0 41926.2 41931.0 42122.6 42124.0 3737.2 3769.3 3775.5 3788.2 3798.2 33595.5 33659.7 33727.3 33757.8 33800.8 5585.8 5589.0 5631.0 5634.1 5734.4 210881.9 213043.0 213911.0 213951.0 214554.0 46420.5 53412.5 53893.5 53922.7 54036.7 57834.7 57950.0 57978.8 58051.4 58079.0 17159.4 17323.6 17326.4 17338.0 17341.5 14481.7 14505.3 14506.3 14508.9 14511.1 15204.7 15209.8 15236.5 15414.0 15444.2 5877.4 5964.3 5978.8 6162.6 6193.9 1115.5 1119.4 1128.4 1129.4 1137.8 25589.1 25615.2 25701.6 25897.0 26064.6 1220.6 1238.8 1251.4 1254.7 1257.2 13253.8 13499.3 13543.1 13670.5 13748.3 256703.0 259566.0 260243.0 260258.0 261193.0 57742.7 57773.7 57953.0 58263.7 58402.7 1522.3 1528.7 1558.9 1564.6 1592.6 25152.2 25174.0 25360.2 25547.6 25626.6 41643.4 41651.0 41687.0 41798.8 41808.4 229749.0 230031.0 230303.0 231059.0 231155.0 36800.1 42806.0 42964.0 43232.6 43270.0 52768.5 52825.0 52922.7 53165.0 53189.5 38420.8 38497.0 38900.8 38957.0 38995.6 38245.0 38523.2 38565.8 38724.0 38784.4 44491.7 44539.0 44645.3 44693.8 44798.3 36962.3 37066.8 37313.8 37529.8 37584.8 27513.6 27916.4 28111.3 28160.1 28176.3 06:11:02 INFO - PID 3788 | 06:11:02 INFO - PID 3788 | [#2] jquery.html Cycles:180 Average:41163.59 Median:23137.15 stddev:107230.81 (463.5%) stddev-sans-first:107488.33 06:11:02 INFO - PID 3788 | Values: 582.2 591.9 597.6 603.1 603.9 23625.5 24339.8 24360.0 24373.0 24397.4 25327.0 25864.4 26849.7 27033.0 27168.3 6696.7 6875.9 6891.9 6899.7 6900.1 6421.8 6666.0 6693.5 6700.4 6804.0 6658.5 6658.9 6662.8 6666.7 6669.4 6614.3 6654.5 6656.4 6658.4 6879.1 6366.8 6386.2 6437.9 6442.1 6442.9 30279.0 30652.0 30708.2 30737.4 30793.2 2298.0 2323.1 2323.2 2323.2 2328.7 20421.3 20880.0 21246.8 21401.8 21439.2 2486.1 2512.6 2548.9 2587.3 2590.6 138940.0 145230.3 154577.2 160654.0 160904.2 15383.8 15969.2 15977.4 16035.4 16789.2 26184.9 26327.3 26404.6 26408.3 26413.1 10669.8 10886.5 10921.9 10991.2 11076.0 10072.3 10073.4 10186.8 10194.3 10204.6 9784.0 9872.7 9877.9 9905.8 9993.7 2741.2 2798.3 2846.6 2864.9 2905.3 1016.6 1027.3 1030.6 1030.6 1049.4 20783.2 21019.7 21039.6 21181.3 21211.3 1093.1 1099.4 1102.7 1105.3 1108.7 11422.0 11825.4 11859.3 11996.8 12036.3 622098.0 642079.0 646846.0 649735.0 652981.0 127555.0 132371.0 135678.0 136224.3 136780.3 1117.9 1172.5 1226.2 1226.8 1291.5 22856.9 22979.9 23063.7 23210.7 23462.5 62461.4 62742.7 63685.7 64286.7 64840.7 78080.2 79755.2 79760.0 80331.6 80897.0 15669.3 15835.4 15962.4 16068.4 16082.4 22814.8 22904.4 24679.1 25031.2 25327.9 18935.5 19128.7 20264.0 20613.5 20619.0 17412.5 17712.5 17921.6 18361.2 18441.8 18912.6 20568.4 20706.8 20827.6 20899.9 15682.3 15751.7 15767.7 15799.1 15799.2 17739.3 18448.9 19990.2 20011.9 20251.0 06:11:02 INFO - PID 3788 | 06:11:02 INFO - PID 3788 | [#3] mootools.html Cycles:180 Average:10297.29 Median:2704.21 stddev:7754.64 (286.8%) stddev-sans-first:7747.61 06:11:02 INFO - PID 3788 | Values: 1404.9 1456.1 1476.7 1480.8 1487.9 16524.0 17189.7 17211.0 17244.7 17245.0 16804.1 16895.4 16946.7 16982.3 16986.2 2581.6 2729.6 2739.5 2741.6 2752.5 2712.7 2722.2 2773.8 2778.9 2781.8 2797.3 2839.4 2842.0 2842.2 2856.2 2701.1 2735.7 2743.3 2744.5 2752.0 2664.0 2695.3 2702.9 2702.9 2705.5 16387.8 16712.5 16719.3 16721.9 16746.7 8375.3 8645.5 8646.0 8678.1 8681.3 5233.4 5364.4 5544.1 5551.5 5575.2 2053.7 2071.5 2071.6 2138.2 2145.9 29909.4 30297.5 30327.0 30349.8 31060.7 7222.5 7224.8 7276.8 7362.2 7423.6 19557.5 19583.5 19583.8 19586.1 19602.2 8366.0 8579.0 8585.4 8622.2 8625.2 7910.3 7914.8 7955.2 7984.5 7989.7 5569.2 5730.4 5731.1 5785.6 5826.6 1590.2 1630.6 1655.7 1665.7 1685.7 945.2 953.1 956.9 967.1 968.0 8325.5 8330.5 8353.0 8457.8 8477.7 769.1 782.3 787.6 788.8 800.7 4696.7 5261.9 5671.9 5690.2 5747.6 24257.9 24767.4 24826.3 24830.4 25361.4 24775.9 24784.5 24865.0 25029.6 25098.7 12124.7 12545.2 12683.0 12745.8 12772.7 8506.7 8571.4 8724.8 8759.9 8857.0 20990.9 21939.5 22119.1 22237.3 22579.4 21650.4 21938.2 22033.3 22096.2 22339.6 11755.9 11856.1 11928.0 11942.2 11942.3 15265.8 15297.4 15304.7 15319.6 15334.9 12102.1 12221.1 12224.4 12284.5 12535.0 11928.6 12181.8 12194.6 12239.6 12348.2 10292.8 10328.1 10381.8 10427.5 10555.4 7370.9 7424.3 7529.4 7548.2 7624.0 7354.7 7487.4 7492.6 7522.2 7612.8 06:11:02 INFO - PID 3788 | 06:11:02 INFO - PID 3788 | [#4] prototype.html Cycles:180 Average:5557.21 Median:6158.80 stddev:1548.89 (25.1%) stddev-sans-first:1506.74 06:11:02 INFO - PID 3788 | Values: 539.2 544.9 556.6 567.5 584.7 6244.8 6266.2 6294.3 6303.1 6314.1 6140.6 6177.0 6183.4 6241.3 6242.0 5008.2 5061.8 5079.6 5080.6 5100.2 4978.5 4990.1 4994.2 5038.7 5048.4 4796.6 4882.2 4915.4 5011.7 5017.9 4877.3 4899.9 4903.6 4919.4 4938.8 4341.8 4429.4 4438.7 4449.3 4473.1 5966.8 6029.2 6047.4 6087.3 6094.3 5692.1 5732.5 5758.7 5793.7 5804.3 6537.8 6549.0 6580.7 6606.6 6615.5 4947.6 5007.8 5019.7 5025.0 5036.1 6610.8 6620.7 6792.8 6852.5 6919.7 5072.2 5099.6 5108.7 5143.4 5154.3 5193.8 5210.1 5218.7 5228.7 5229.8 5735.1 5749.9 5773.9 5795.1 5802.3 6391.3 6422.2 6440.7 6531.1 6573.8 1762.8 1796.8 1796.9 1797.7 1808.2 1230.3 1277.8 1281.7 1290.0 1294.7 5940.3 5958.7 5988.5 6044.4 6129.4 6512.5 6553.3 6557.2 6622.5 6724.8 5915.9 6009.2 6047.9 6054.5 6105.9 3438.9 3493.4 3494.8 3512.8 3534.0 6936.8 6972.3 6996.5 6998.2 7003.5 6811.3 6874.4 6897.4 6942.2 6972.7 6793.7 6815.9 6837.4 6883.8 6914.8 6593.8 6597.9 6676.0 6703.5 6731.4 6531.8 6579.8 6594.8 6619.6 6704.3 6807.2 6914.4 6927.3 6980.7 6981.3 5082.3 5134.8 5149.3 5154.8 5183.3 6479.7 6538.4 6598.9 6733.0 6745.0 6386.2 6399.0 6445.8 6487.3 6496.8 6357.7 6434.6 6437.3 6457.2 6458.4 6315.0 6334.4 6343.8 6421.9 6423.1 6473.4 6474.5 6481.6 6521.1 6541.9 6282.3 6340.8 6347.4 6363.6 6423.6 06:11:02 INFO - PID 3788 | 06:11:02 INFO - PID 3788 | [#5] yui.html Cycles:180 Average:27889.00 Median:18488.31 stddev:41956.95 (226.9%) stddev-sans-first:42025.86 06:11:02 INFO - PID 3788 | Values: 942.9 987.0 989.2 997.1 1018.8 19529.4 20036.6 20060.1 20062.6 20224.0 18667.5 19104.7 19146.6 19194.0 19201.2 1061.4 1084.1 1084.5 1084.7 1087.0 1045.2 1060.6 1060.9 1071.4 1074.2 1126.5 1131.1 1137.4 1137.4 1139.1 1073.9 1104.7 1125.0 1126.8 1127.9 810.5 820.2 820.8 821.8 822.8 19444.6 19725.1 19775.7 19793.0 19800.1 21704.6 22251.9 22554.1 22569.2 22618.4 18319.6 18342.2 18439.7 18477.4 18530.4 4032.7 4060.5 4063.7 4078.7 4082.4 151344.0 152107.0 152753.0 154174.0 155836.0 16746.9 16863.0 16937.8 17122.9 17172.9 32447.8 32503.2 32553.0 32729.3 32771.5 8276.9 8454.1 8533.9 8559.0 8559.6 4218.4 4279.0 4282.8 4314.6 4317.3 6082.5 6103.3 6115.5 6186.0 6226.8 1121.7 1147.3 1150.5 1156.9 1160.3 684.2 697.1 705.7 708.3 710.8 11108.5 11478.7 11801.3 12079.5 12334.3 663.5 680.9 685.7 689.9 693.2 5402.0 5407.2 5535.7 5588.2 5602.7 150136.0 151886.0 154457.0 154894.0 156810.0 104294.0 128118.4 130056.0 132482.0 139364.0 113998.4 114199.4 115566.4 117805.0 117923.4 12495.3 13040.3 13136.9 13143.4 13169.9 55625.0 56793.0 57001.7 57340.7 57466.1 69975.7 72703.3 73375.3 73553.0 74356.0 18217.4 18499.3 18591.7 18598.5 18735.5 18934.9 18987.8 19017.9 19061.3 19122.2 17492.3 17721.6 17804.9 17935.0 17971.4 16272.6 16357.9 16488.0 16537.0 16537.3 16779.7 16958.4 16986.7 17014.7 17102.3 12589.6 12711.1 12795.6 12813.3 13185.5 11894.6 11960.4 12145.8 12231.6 12368.8 06:11:02 INFO - PID 3788 | -------- Summary: end -------- 06:11:02 INFO - PID 3788 | 06:11:03 INFO - PID 3788 | 06:11:03 INFO - PID 3788 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 06:11:03 INFO - PID 3788 | 06:11:03 INFO - TEST-INFO | 3788: exit 0 06:11:03 INFO - TEST-OK | dromaeo_css | took 1111021ms 06:11:03 INFO - TEST-START | kraken 06:11:03 INFO - Initialising browser for kraken test... 06:11:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59209/getInfo.html -profile /tmp/tmp7lRam5/profile 06:11:03 INFO - TEST-INFO | started process 4156 (/builds/slave/test/build/application/firefox/firefox http://localhost:59209/getInfo.html) 06:11:08 INFO - TEST-INFO | 4156: exit 0 06:11:08 INFO - Browser initialized. 06:11:08 INFO - Running cycle 1/1 for kraken test... 06:11:08 INFO - Using env: {'DISPLAY': ':0', 06:11:08 INFO - 'HOME': '/home/cltbld', 06:11:08 INFO - 'JSGC_DISABLE_POISONING': '1', 06:11:08 INFO - 'LANG': 'en_US.UTF-8', 06:11:08 INFO - 'LANGUAGE': 'en_US:en', 06:11:08 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:11:08 INFO - 'LOGNAME': 'cltbld', 06:11:08 INFO - 'MAIL': '/var/mail/cltbld', 06:11:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:11:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:11:08 INFO - 'MOZ_CRASHREPORTER': '1', 06:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:08 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:11:08 INFO - 'MOZ_NO_REMOTE': '1', 06:11:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:08 INFO - 'NO_EM_RESTART': '1', 06:11:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:08 INFO - 'PWD': '/builds/slave/test', 06:11:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:11:08 INFO - 'RUST_BACKTRACE': 'full', 06:11:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:11:08 INFO - 'SHELL': '/bin/bash', 06:11:08 INFO - 'SHLVL': '1', 06:11:08 INFO - 'STYLO_FORCE_DISABLED': '1', 06:11:08 INFO - 'TERM': 'linux', 06:11:08 INFO - 'TMOUT': '86400', 06:11:08 INFO - 'USER': 'cltbld', 06:11:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570', 06:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:08 INFO - '_': '/tools/buildbot/bin/python'} 06:11:08 INFO - TEST-INFO | started process 4346 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7lRam5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:09 INFO - PID 4346 | 06:11:09 INFO - PID 4346 | (/builds/slave/test/build/application/firefox/firefox:4396): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:11:09 INFO - PID 4346 | 06:11:19 INFO - PID 4346 | RSS: Main: 166223872 06:11:19 INFO - PID 4346 | 06:11:22 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:59209/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59209/tests/kraken/driver.html?testName=audio-beat-detection) 06:11:23 INFO - PID 4346 | RSS: Main: 171409408 06:11:23 INFO - PID 4346 | 06:11:25 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:59209/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59209/tests/kraken/driver.html?testName=audio-dft) 06:11:26 INFO - PID 4346 | RSS: Main: 171696128 06:11:26 INFO - PID 4346 | 06:11:29 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:59209/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59209/tests/kraken/driver.html?testName=audio-fft) 06:11:30 INFO - PID 4346 | RSS: Main: 166924288 06:11:30 INFO - PID 4346 | 06:11:32 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:59209/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59209/tests/kraken/driver.html?testName=audio-oscillator) 06:11:32 INFO - PID 4346 | RSS: Main: 168169472 06:11:32 INFO - PID 4346 | 06:11:34 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:59209/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59209/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:11:35 INFO - PID 4346 | RSS: Main: 168284160 06:11:35 INFO - PID 4346 | 06:11:38 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:59209/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59209/tests/kraken/driver.html?testName=imaging-darkroom) 06:11:39 INFO - PID 4346 | RSS: Main: 171618304 06:11:39 INFO - PID 4346 | 06:11:42 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:59209/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59209/tests/kraken/driver.html?testName=imaging-desaturate) 06:11:43 INFO - PID 4346 | RSS: Main: 170913792 06:11:43 INFO - PID 4346 | 06:11:46 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:59209/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59209/tests/kraken/driver.html?testName=json-parse-financial) 06:11:46 INFO - PID 4346 | RSS: Main: 170586112 06:11:46 INFO - PID 4346 | 06:11:48 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:59209/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59209/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:11:48 INFO - PID 4346 | RSS: Main: 170946560 06:11:48 INFO - PID 4346 | 06:11:50 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:59209/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59209/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:11:51 INFO - PID 4346 | RSS: Main: 170979328 06:11:51 INFO - PID 4346 | 06:11:53 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:59209/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59209/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:11:53 INFO - PID 4346 | RSS: Main: 167931904 06:11:53 INFO - PID 4346 | 06:11:56 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:59209/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:11:56 INFO - PID 4346 | RSS: Main: 167907328 06:11:56 INFO - PID 4346 | 06:11:59 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:59209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:00 INFO - PID 4346 | RSS: Main: 168775680 06:12:00 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | Cycle 1(1): loaded http://localhost:59209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59209/tests/kraken/driver.html?testName=ai-astar) 06:12:02 INFO - PID 4346 | RSS: Main: 170172416 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | __start_tp_report 06:12:02 INFO - PID 4346 | _x_x_mozilla_page_load 06:12:02 INFO - PID 4346 | _x_x_mozilla_page_load_details 06:12:02 INFO - PID 4346 | |i|pagename|runs| 06:12:02 INFO - PID 4346 | |0;ai-astar;107;105;105;106;106;108;105;106;107;108 06:12:02 INFO - PID 4346 | |1;audio-beat-detection;113;118;114;114;111;112;112;114;148;116 06:12:02 INFO - PID 4346 | |2;audio-dft;161;162;163;161;161;163;162;161;163;165 06:12:02 INFO - PID 4346 | |3;audio-fft;74;73;75;73;73;73;74;73;74;75 06:12:02 INFO - PID 4346 | |4;audio-oscillator;78;79;78;78;77;78;78;78;83;79 06:12:02 INFO - PID 4346 | |5;imaging-gaussian-blur;112;115;113;113;117;115;114;114;111;114 06:12:02 INFO - PID 4346 | |6;imaging-darkroom;148;153;150;149;150;153;152;150;150;150 06:12:02 INFO - PID 4346 | |7;imaging-desaturate;94;94;94;94;94;94;95;95;98;99 06:12:02 INFO - PID 4346 | |8;json-parse-financial;45;44;45;43;45;46;45;44;44;43 06:12:02 INFO - PID 4346 | |9;json-stringify-tinderbox;38;38;39;38;39;38;39;38;39;42 06:12:02 INFO - PID 4346 | |10;stanford-crypto-aes;72;72;72;73;73;74;72;77;72;76 06:12:02 INFO - PID 4346 | |11;stanford-crypto-ccm;108;110;104;109;123;104;113;107;114;108 06:12:02 INFO - PID 4346 | |12;stanford-crypto-pbkdf2;172;165;158;163;162;160;160;166;157;160 06:12:02 INFO - PID 4346 | |13;stanford-crypto-sha256-iterative;61;60;59;59;61;61;59;66;62;58 06:12:02 INFO - PID 4346 | __end_tp_report 06:12:02 INFO - PID 4346 | __start_cc_report 06:12:02 INFO - PID 4346 | _x_x_mozilla_cycle_collect,878 06:12:02 INFO - PID 4346 | __end_cc_report 06:12:02 INFO - PID 4346 | __startTimestamp1505308322267__endTimestamp 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | ------- Summary: start ------- 06:12:02 INFO - PID 4346 | Number of tests: 14 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | [#0] ai-astar Cycles:10 Average:106.30 Median:106.50 stddev:1.16 (1.1%) stddev-sans-first:1.20 06:12:02 INFO - PID 4346 | Values: 107.0 105.0 105.0 106.0 106.0 108.0 105.0 106.0 107.0 108.0 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:114.00 stddev:11.01 (9.7%) stddev-sans-first:11.58 06:12:02 INFO - PID 4346 | Values: 113.0 118.0 114.0 114.0 111.0 112.0 112.0 114.0 148.0 116.0 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.32 (0.8%) stddev-sans-first:1.32 06:12:02 INFO - PID 4346 | Values: 161.0 162.0 163.0 161.0 161.0 163.0 162.0 161.0 163.0 165.0 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | [#3] audio-fft Cycles:10 Average:73.70 Median:74.00 stddev:0.82 (1.1%) stddev-sans-first:0.87 06:12:02 INFO - PID 4346 | Values: 74.0 73.0 75.0 73.0 73.0 73.0 74.0 73.0 74.0 75.0 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:78.00 stddev:1.65 (2.1%) stddev-sans-first:1.73 06:12:02 INFO - PID 4346 | Values: 78.0 79.0 78.0 78.0 77.0 78.0 78.0 78.0 83.0 79.0 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:1.69 (1.5%) stddev-sans-first:1.66 06:12:02 INFO - PID 4346 | Values: 112.0 115.0 113.0 113.0 117.0 115.0 114.0 114.0 111.0 114.0 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.00 stddev:1.65 (1.1%) stddev-sans-first:1.48 06:12:02 INFO - PID 4346 | Values: 148.0 153.0 150.0 149.0 150.0 153.0 152.0 150.0 150.0 150.0 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.50 stddev:1.85 (2.0%) stddev-sans-first:1.92 06:12:02 INFO - PID 4346 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 98.0 99.0 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | [#8] json-parse-financial Cycles:10 Average:44.40 Median:45.00 stddev:0.97 (2.1%) stddev-sans-first:1.00 06:12:02 INFO - PID 4346 | Values: 45.0 44.0 45.0 43.0 45.0 46.0 45.0 44.0 44.0 43.0 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | [#9] json-stringify-tinderbox Cycles:10 Average:38.80 Median:39.00 stddev:1.23 (3.2%) stddev-sans-first:1.27 06:12:02 INFO - PID 4346 | Values: 38.0 38.0 39.0 38.0 39.0 38.0 39.0 38.0 39.0 42.0 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:73.00 stddev:1.83 (2.5%) stddev-sans-first:1.88 06:12:02 INFO - PID 4346 | Values: 72.0 72.0 72.0 73.0 73.0 74.0 72.0 77.0 72.0 76.0 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | [#11] stanford-crypto-ccm Cycles:10 Average:110.00 Median:109.50 stddev:5.62 (5.1%) stddev-sans-first:5.91 06:12:02 INFO - PID 4346 | Values: 108.0 110.0 104.0 109.0 123.0 104.0 113.0 107.0 114.0 108.0 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.50 stddev:4.45 (2.7%) stddev-sans-first:3.03 06:12:02 INFO - PID 4346 | Values: 172.0 165.0 158.0 163.0 162.0 160.0 160.0 166.0 157.0 160.0 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:61.00 stddev:2.27 (3.7%) stddev-sans-first:2.40 06:12:02 INFO - PID 4346 | Values: 61.0 60.0 59.0 59.0 61.0 61.0 59.0 66.0 62.0 58.0 06:12:02 INFO - PID 4346 | -------- Summary: end -------- 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 06:12:02 INFO - PID 4346 | 06:12:02 INFO - PID 4346 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:12:02 INFO - TEST-INFO | 4346: exit 0 06:12:02 INFO - TEST-OK | kraken | took 59332ms 06:12:02 INFO - SUITE-END | took 1170s 06:12:03 INFO - Completed test suite (00:19:30) 06:12:03 INFO - javascript benchmark 06:12:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9035.033207212102, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3895.065184355755, 3898.785566793825, 3917.4907262055945, 3927.783971881547, 3935.8032098395083, 6277.748890044393, 6294.213223347082, 6349.269833969095, 6379.13881625981, 6426.614403135815, 6342.714577843996, 6385.138006369139, 6416.4225219730215, 6419.165508483902, 6483.416492515673, 5652.180433837091, 5746.597738158331, 5773.30720313563, 5796.884062318751, 5810.418958104198, 123.46302701277385, 5718.142278658193, 5765.740541675635, 5811.331696854852, 5823.097419899901, 5294.973525132369, 5585.832425027255, 5673.432656734314, 5768.97115514424, 5782.653040817564, 5687.317521897398, 5695.857603559903, 5707.0, 5714.257146570919, 5740.856478588027, 5666.433356664342, 5685.431456854281, 5689.971550142264, 5694.316681998145, 5701.4298570142655, 6315.873682526324, 6395.616263024233, 6423.93576064238, 6439.420452159328, 6460.676966151674, 6809.795706128824, 6823.078884350599, 6913.827154321182, 6931.41083007945, 6987.510874238806, 6786.287439818797, 6918.481113916426, 6924.58452492847, 6926.099607051102, 7025.648717564152, 6345.809625711236, 6356.046593011085, 6356.364363563653, 6356.586821856565, 6384.968075159641, 7050.964745176241, 7084.645767711594, 7111.679974401164, 7124.92875071253, 7206.2793720627515, 6823.590584564942, 6824.965875170592, 6901.551399159039, 6912.343327383891, 6916.792496225121, 6815.795526134224, 6922.5154239202775, 6970.372666459942, 7023.8595228095155, 7036.577805331696, 6834.0, 6861.588304701734, 6885.036094946711, 6896.379325860697, 6906.965465172742, 6833.555818871758, 6898.172219333712, 6902.689378977958, 6930.410915072174, 6951.131108611424, 5008.949910500921, 5035.018171456604, 5081.644284900021, 5086.567641750418, 5087.796488140507, 4509.075639493962, 4512.548745125527, 4537.77311134442, 4552.044070745181, 4561.1333846569705, 6362.968185159137, 6373.0, 6378.45783108441, 6389.0, 6407.487401007908, 6831.04365388846, 6923.446124310043, 6933.064036355128, 6935.133108361455, 6938.895916561256, 6310.495160387158, 6311.495080393557, 6316.336784637639, 6390.904136437957, 6405.935940640534, 5484.149956756709, 5513.558915286768, 5520.558355331564, 5546.722663866791, 5591.3569939456665, 7140.357367836919, 7166.605836679033, 7170.067891174114, 7174.964125179341, 7180.820479488055, 6685.966570167118, 6843.555168914005, 6862.0, 6875.656217189021, 6942.51402401827, 7113.502054856111, 7218.639068046472, 7221.747238846615, 7227.421806255592, 7257.891131632924, 6758.986152077031, 6821.624810635462, 6845.0, 6936.7225310989015, 6943.861122777617, 6836.555623884432, 6931.826704332432, 6964.547304425196, 7009.439244860501, 7019.438444924496, 6616.437602803816, 6636.83407914806, 6683.131192944886, 6689.76585819494, 6689.933100668931, 6555.541112122106, 6567.507436942344, 6747.089142965637, 6751.088603038724, 6752.08846805675, 6567.802965910839, 6574.934250657623, 6664.50016248793, 6666.100076489612, 6666.566673166229, 6569.24453687832, 6648.966755166193, 6660.766873159416, 6695.230048544479, 6786.898196527155, 6459.967700161657, 6490.675466226764, 6523.3150519194805, 6527.5430719849155, 6548.345165483413], "value": 6253.560598067552, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [959.908808663177, 981.2542467724527, 986.5511192407455, 995.2336700740426, 1001.6043662753212, 44694.329585056206, 45546.0, 45601.08797824046, 45634.543654563524, 45777.77111114448, 42105.78947105268, 42287.78856105723, 42288.365674514906, 42464.0, 42611.14777704444, 7455.813604659873, 7514.6618402172035, 7565.659545320446, 7569.243075692441, 7569.280918312751, 7415.1843297237265, 7467.9626601867185, 7479.663415146331, 7487.925120748804, 7493.063367079088, 7777.727779527718, 7902.170272121431, 7906.960465197666, 7910.0, 7917.722879699211, 7772.494787838772, 7801.648925798353, 7866.1347251802545, 7868.842623147533, 8019.438639295252, 8000.63997120131, 8076.717314894009, 8077.676892924276, 8079.353651707849, 8086.555239461827, 41606.0, 41926.1614767706, 41931.0, 42122.57877421248, 42124.0, 3737.2338670572467, 3769.3403654360377, 3775.4903088083033, 3788.1666033472593, 3798.2403519295976, 33595.496067559005, 33659.6634033659, 33727.32545349079, 33757.83121084404, 33800.83099584511, 5585.776568937237, 5589.049861523551, 5631.042722737145, 5634.098544232903, 5734.369219385864, 210881.9455902726, 213043.0, 213911.0, 213951.0, 214554.0, 46420.535794642296, 53412.46587534075, 53893.461065388845, 53922.730386347816, 54036.729816350664, 57834.7108264456, 57950.0, 57978.8404231913, 58051.4194858046, 58079.0, 17159.399421020204, 17323.56691082733, 17326.393576225022, 17338.0, 17341.479755607354, 14481.710365792625, 14505.274736263145, 14506.347214375379, 14508.85491145075, 14511.1293322401, 15204.695906081817, 15209.771853422208, 15236.466723664618, 15414.0, 15444.150571718663, 5877.353491115974, 5964.314103878023, 5978.760849566055, 6162.630242185483, 6193.907091393633, 1115.537052123376, 1119.4011204005817, 1128.3568366031448, 1129.412705393191, 1137.766757814646, 25589.104381346562, 25615.23154305374, 25701.614475782877, 25896.964121435307, 26064.60903086455, 1220.6094049904123, 1238.7584421037811, 1251.380566619511, 1254.6737848159544, 1257.1953949472345, 13253.801192982113, 13499.257540835348, 13543.119697219649, 13670.453181872614, 13748.312584370742, 256703.0, 259566.0, 260243.0, 260258.0, 261193.0, 57742.7112864433, 57773.711131444914, 57953.0, 58263.70868145717, 58402.7079864598, 1522.3453914816514, 1528.6636939873433, 1558.9376424942875, 1564.5932057665088, 1592.6416556274978, 25152.24543263705, 25174.0, 25360.239192824243, 25547.6167857486, 25626.615600766378, 41643.37534937039, 41651.0, 41687.0, 41798.791006044776, 41808.37287440752, 229749.0, 230031.0, 230303.0, 231059.0, 231155.0, 36800.07999800026, 42806.0, 42964.0, 43232.56767432411, 43270.0, 52768.472315276354, 52825.0, 52922.73538632282, 53165.0, 53189.468105318454, 38420.84737457881, 38497.0, 38900.80549597234, 38957.02607434837, 38995.610043900335, 38245.0, 38523.22953540969, 38565.80717096396, 38724.0, 38784.418233725955, 44491.66882328335, 44539.0, 44645.330320045876, 44693.77653111714, 44798.328025079, 36962.26075478529, 37066.8146659265, 37313.813430933755, 37529.81235093807, 37584.812075939444, 27513.587296190173, 27916.44167116687, 28111.297217568906, 28160.130523886466, 28176.29559261035], "value": 18977.349050418343, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.2285471749927, 591.8549955260962, 597.6025942748073, 603.1194456094103, 603.8611119442528, 23625.52748945022, 24339.756602433972, 24360.0, 24373.0, 24397.3900652484, 25327.0, 25864.35339116523, 26849.73150268497, 27033.0, 27168.32079198021, 6696.665166741655, 6875.931240687579, 6891.896621550681, 6899.689513971858, 6900.137482814648, 6421.7752378666755, 6665.966670166642, 6693.464522838186, 6700.363465470772, 6803.965980170092, 6658.467322614203, 6658.933410665904, 6662.800115996528, 6666.699998500079, 6669.43309818666, 6614.305497922745, 6654.4676425886055, 6656.400923916846, 6658.434033107167, 6879.105716256855, 6366.77716279928, 6386.201724784402, 6437.935620643827, 6442.065900444456, 6442.871142577169, 30279.0, 30652.0, 30708.232294192825, 30737.38525229483, 30793.230169245948, 2298.0463107810237, 2323.0939933425807, 2323.163661082009, 2323.1984965187153, 2328.6739856420113, 20421.28525501615, 20880.0, 21246.787532124636, 21401.785982140136, 21439.249626263005, 2486.0677246032737, 2512.57286261336, 2548.9107881224254, 2587.3143616941525, 2590.5984572391308, 138940.0, 145230.27384863008, 154577.22711386372, 160654.0, 160904.19547902304, 15383.846161538242, 15969.201539922957, 15977.360905563879, 16035.43875964359, 16789.24448399825, 26184.8690756545, 26327.34181645474, 26404.60393094105, 26408.339791505365, 26413.07554235631, 10669.786604268027, 10886.455677216107, 10921.945390273157, 10991.175661825395, 11076.0, 10072.345297555636, 10073.395596264247, 10186.847197292047, 10194.28639995208, 10204.591816327413, 9783.951080244553, 9872.654457093968, 9877.851832222523, 9905.80188396228, 9993.700188994342, 2741.2050505353222, 2798.3284011837013, 2846.6014757933904, 2864.8854045838348, 2905.259158914463, 1016.6289304403987, 1027.3271007489957, 1030.5517100061497, 1030.567161792049, 1049.4070849969742, 20783.168673253203, 21019.68470472944, 21039.579208416053, 21181.258655946967, 21211.257605983716, 1093.1091160704, 1099.4173088263233, 1102.691246450995, 1105.3312745788842, 1108.6563165418745, 11422.0, 11825.408729563487, 11859.347735874437, 11996.820047699292, 12036.338001410006, 622098.0, 642079.0, 646846.0, 649735.0, 652981.0, 127555.0, 132371.0, 135678.0, 136224.31887840497, 136780.31609841887, 1117.9385133817718, 1172.5485688010008, 1226.2458587968335, 1226.7607816475702, 1291.520281060385, 22856.885715571316, 22979.88510057439, 23063.654045189673, 23210.65184022275, 23462.530749384576, 62461.375386245556, 62742.68628656828, 63685.68157159184, 64286.67856660687, 64840.675796620715, 78080.2191978073, 79755.20244797478, 79760.0, 80331.59834200791, 80897.0, 15669.294881730577, 15835.366585336458, 15962.441314553935, 16068.35726570924, 16082.35670573164, 22814.771852281265, 22904.427389315402, 24679.136230231856, 25031.249062528153, 25327.873360633817, 18935.526611834815, 19128.71306930425, 20264.0, 20613.484662883548, 20619.0, 17412.47762567125, 17712.46862594124, 17921.641567168324, 18361.173747181143, 18441.815581844545, 18912.621747564695, 20568.382948511568, 20706.792932070486, 20827.58344833125, 20899.8955005224, 15682.294296756445, 15751.68496630084, 15767.68464630678, 15799.131047792482, 15799.21003949821, 17739.290428383236, 18448.907755461136, 19990.20039198416, 20011.899940500203, 20251.0], "value": 12954.006065706633, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.9297535123244, 1456.140876882639, 1476.7341878461875, 1480.84451132631, 1487.888408369372, 16524.0, 17189.656206875854, 17211.0, 17244.655106897855, 17245.0, 16804.075775832323, 16895.408660696878, 16946.745798813026, 16982.320707171697, 16986.235619397125, 2581.5740402833558, 2729.6314997475383, 2739.5479745842013, 2741.575055866334, 2752.545829938058, 2712.715164907686, 2722.169738229839, 2773.778097752175, 2778.8749506272165, 2781.7913656475844, 2797.314657908815, 2839.3895312507807, 2841.9857900710467, 2842.2183899427614, 2856.157433557106, 2701.0951331304036, 2735.685396179445, 2743.341598016482, 2744.4511097780523, 2751.9862400688066, 2664.0, 2695.258803828943, 2702.8783704733137, 2702.9189124326303, 2705.499482595726, 16387.83612163887, 16712.49862504127, 16719.331226750914, 16721.916390418093, 16746.748798767905, 8375.329973602098, 8645.52449615271, 8646.048934617187, 8678.132186781335, 8681.262092722063, 5233.371995360543, 5364.383095943977, 5544.0575102232315, 5551.528120109796, 5575.163725441216, 2053.671412573981, 2071.54426026274, 2071.616750901073, 2138.240924471821, 2145.903434345458, 29909.401811963857, 30297.545536816964, 30327.0, 30349.848250758605, 31060.689393106004, 7222.53053551528, 7224.783256502314, 7276.7816965490065, 7362.153352364439, 7423.62881855905, 19557.51106222356, 19583.510412239808, 19583.804161958484, 19586.118624661925, 19602.215911363386, 8365.95817020911, 8579.0, 8585.441946273471, 8622.180892815173, 8625.223729864218, 7910.288074073361, 7914.802129946797, 7955.24425179607, 7984.481008734414, 7989.680412783539, 5569.220309156722, 5730.426957304319, 5731.108734117731, 5785.566082543826, 5826.592138550345, 1590.1651632892824, 1630.5760502269259, 1655.6771429571118, 1665.6918470083074, 1685.7050016247108, 945.1682519382899, 953.1421720451649, 956.9473678947725, 967.0957654592978, 968.0174622757906, 8325.458845175044, 8330.458520196167, 8353.0, 8457.788555286166, 8477.703280385156, 769.1270408086862, 782.3115658220729, 787.582581231948, 788.8067423481169, 800.6957356204605, 4696.671233013724, 5261.868453288698, 5671.886562268732, 5690.231818704422, 5747.597668163272, 24257.87871060669, 24767.38081547976, 24826.255212343298, 24830.37924051913, 25361.365965851, 24775.876120619283, 24784.5043099137, 24865.0, 25029.62455563168, 25098.74901250964, 12124.696882578006, 12545.247285162919, 12683.0, 12745.808812867814, 12772.744545109046, 8506.74479765608, 8571.442856214326, 8724.825503490021, 8759.868601970848, 8857.0, 20990.895045524674, 21939.451513712283, 22119.115235390404, 22237.332880013626, 22579.43551411228, 21650.35048948534, 21938.232161874257, 22033.33899983003, 22096.2266320678, 22339.553208936057, 11755.88244117548, 11856.051515878882, 11928.045756339645, 11942.223755455867, 11942.343171125323, 15265.847341526443, 15297.388104475696, 15304.693906121593, 15319.617009574404, 15334.9233253833, 12102.09234307448, 12221.083418743807, 12224.44989975471, 12284.508619655113, 12535.0, 11928.582499612472, 12181.75636487283, 12194.57318993831, 12239.571614993432, 12348.197367171106, 10292.845607316047, 10328.070473657406, 10381.792364152825, 10427.530761115617, 10555.41945192991, 7370.889436658347, 7424.257574242532, 7529.435292353205, 7548.1697013329585, 7624.0, 7354.70581176747, 7487.363574096045, 7492.587907664913, 7522.210167932507, 7612.80967975805], "value": 7137.734973995447, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.1885212754801, 544.9182622606609, 556.6326224691704, 567.5147748674881, 584.7485581200085, 6244.782267457842, 6266.1540692006565, 6294.307626161119, 6303.054541818724, 6314.116023756677, 6140.600860944036, 6177.0, 6183.443490085902, 6241.282252540959, 6242.0, 5008.223725322581, 5061.848144555669, 5079.593632509391, 5080.59355251579, 5100.225832883676, 4978.452370239271, 4990.101781679296, 4994.175960966436, 5038.697678139305, 5048.368953880765, 4796.640251981098, 4882.2432522958825, 4915.361003069596, 5011.749412529359, 5017.949820501803, 4877.292792545079, 4899.853004409855, 4903.583195428393, 4919.360483137205, 4938.80244790208, 4341.826326946918, 4429.379886815848, 4438.7114837535455, 4449.288113901793, 4473.105378924228, 5966.791162309299, 6029.155918171459, 6047.395260473962, 6087.269527656666, 6094.299155597118, 5692.117721753135, 5732.484076433099, 5758.74085666146, 5793.725380416302, 5804.2744656917885, 6537.803865884031, 6548.967255163694, 6580.736770529173, 6606.570572912745, 6615.503837212228, 4947.604191664658, 5007.799688012475, 5019.698818070928, 5024.9748751256375, 5036.11867923112, 6610.8016759497295, 6620.702068406933, 6792.76225332111, 6852.45180385573, 6919.719851827378, 5072.213806859942, 5099.643024988215, 5108.66793658411, 5143.382794064736, 5154.252633368215, 5193.792248310101, 5210.088234558937, 5218.66078704883, 5228.738563071907, 5229.816956406507, 5735.11105778605, 5749.8562535936935, 5773.902958437883, 5795.1017592273265, 5802.33273173582, 6391.3289104643345, 6422.165118534561, 6440.710168042449, 6531.118299029666, 6573.835654108686, 1762.8149044350414, 1796.8203179681927, 1796.9281228750965, 1797.703378942486, 1808.1592059692307, 1230.2887747338427, 1277.7636137314626, 1281.705207802192, 1289.9742005159844, 1294.7151626642124, 5940.34656187819, 5958.731857066442, 5988.520918326523, 6044.365341639153, 6129.448349648553, 6512.5441219115155, 6553.263385202925, 6557.180352455943, 6622.503312251504, 6724.7646332378135, 5915.940840591539, 6009.188759517497, 6047.879042419215, 6054.485368743618, 6105.877882442326, 3438.9312213755584, 3493.3886569850174, 3494.790312581253, 3512.7892326459983, 3533.982330088333, 6936.79189624312, 6972.337627925339, 6996.475264355194, 6998.16022077354, 7003.4747393944635, 6811.284815094344, 6874.415674667609, 6897.379235868796, 6942.1669399671355, 6972.744905916882, 6793.660316984131, 6815.863682726318, 6837.35045170708, 6883.7590684325805, 6914.757983470555, 6593.80218593443, 6597.934020659732, 6676.0, 6703.530752847254, 6731.418116742464, 6531.836704082436, 6579.769708060387, 6594.769183078569, 6619.602823830585, 6704.318272690768, 6807.21717002551, 6914.4468442525485, 6927.3419025192525, 6980.720771169096, 6981.301869812978, 5082.33929589151, 5134.845954621367, 5149.279100925948, 5154.768035438339, 5183.3261675983385, 6479.732093767144, 6538.411542961157, 6598.868022639616, 6733.0, 6745.0, 6386.201724784402, 6399.0, 6445.806625801233, 6487.3188315226225, 6496.805095847132, 6357.650329231752, 6434.581752186093, 6437.291897891135, 6457.160569125984, 6458.418742313214, 6315.0, 6334.398232167937, 6343.777967771106, 6421.903671444838, 6423.132877061536, 6473.417392434703, 6474.471413079788, 6481.611103333815, 6521.054447105048, 6541.901871471837, 6282.308946016026, 6340.778072767431, 6347.428731414195, 6363.61818290904, 6423.646699431576], "value": 5112.656441708737, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [942.888468055417, 986.9950650246748, 989.2333441582772, 997.1225321716893, 1018.7605912610535, 19529.414117576478, 20036.59926801463, 20060.097295621676, 20062.59874802503, 20223.98880055995, 18667.533311667215, 19104.713429298536, 19146.617067658637, 19193.999999999964, 19201.231950721954, 1061.3790932304591, 1084.0893649334557, 1084.511969613673, 1084.6908631040155, 1087.0434018064132, 1045.2474218562622, 1060.6499855047816, 1060.931039482435, 1071.4214324264926, 1074.2319241742152, 1126.5043380912373, 1131.1007748839693, 1137.3744440557703, 1137.419915842922, 1139.0887290167875, 1073.8603981482436, 1104.6962085426571, 1125.038092430972, 1126.8140756775163, 1127.9041281491084, 810.4610434061342, 820.1839170025803, 820.7619790260817, 821.843849668561, 822.7901885019342, 19444.611107777906, 19725.11236994339, 19775.703364449546, 19793.0, 19800.108995095256, 21704.56590868174, 22251.888740556355, 22554.097836086537, 22569.210077647203, 22618.434539136488, 18319.633607327913, 18342.174602142935, 18439.72340414895, 18477.353292634692, 18530.444086677286, 4032.7378720383376, 4060.5330387005283, 4063.674906007512, 4078.6737061035046, 4082.387641853716, 151344.0, 152107.0, 152753.0, 154173.99999999886, 155836.0, 16746.91626541884, 16863.0, 16937.830621693873, 17122.914385427994, 17172.914135429244, 32447.837760811046, 32503.18742031468, 32553.0, 32729.34541309208, 32771.50842737313, 8276.917230827736, 8454.070052294242, 8533.914660853436, 8559.0, 8559.572021398904, 4218.430511880918, 4278.957210427918, 4282.807273672693, 4314.590113939171, 4317.309230523101, 6082.513398928075, 6103.328633850273, 6115.541334399938, 6186.041163619646, 6226.813195604139, 1121.7083558274908, 1147.3173461790389, 1150.4535345710888, 1156.8611766588062, 1160.2980196980873, 684.1619016704498, 697.0659316515893, 705.7036044861171, 708.3235510087853, 710.8294009437698, 11108.500117494732, 11478.655640330804, 11801.29192248468, 12079.51681932713, 12334.259944403364, 663.4559661077869, 680.8740383029156, 685.6640246279287, 689.9275576064441, 693.1612748574181, 5402.0, 5407.215953686772, 5535.6955367455175, 5588.189712491666, 5602.719864006865, 150136.0, 151886.0, 154457.0, 154894.0, 156810.0, 104294.0, 128118.35940820236, 130056.0, 132482.0, 139364.0, 113998.43000784943, 114199.42900285445, 115566.42216788694, 117805.0, 117923.41038294754, 12495.25028498293, 13040.282784446947, 13136.868631313564, 13143.408546615234, 13169.946404287442, 55625.0, 56793.0, 57001.71499142478, 57340.71329643492, 57466.13800793075, 69975.65012174906, 72703.27296726964, 73375.26624733684, 73553.0, 74356.0, 18217.362392316205, 18499.260029598667, 18591.72112418342, 18598.53503662419, 18735.531611709815, 18934.905325473286, 18987.810121898605, 19017.904910475358, 19061.332853350064, 19122.235110595422, 17492.300307988047, 17721.645567088843, 17804.91097544504, 17935.0, 17971.37100201487, 16272.593185170466, 16357.918210408872, 16488.0, 16537.0, 16537.255823488213, 16779.74830377521, 16958.406455773988, 16986.74519882178, 17014.659706805545, 17102.315907363565, 12589.559365422167, 12711.110222284351, 12795.552155674506, 12813.295268760308, 13185.53850615224, 11894.643160704847, 11960.401979900797, 12145.817812732992, 12231.633051008484, 12368.75262494763], "value": 9695.63947312196, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1386.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 105.0, 106.0, 106.0, 108.0, 105.0, 106.0, 107.0, 108.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 114.0, 114.0, 111.0, 112.0, 112.0, 114.0, 148.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 161.0, 161.0, 163.0, 162.0, 161.0, 163.0, 165.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 73.0, 73.0, 73.0, 74.0, 73.0, 74.0, 75.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 78.0, 77.0, 78.0, 78.0, 78.0, 83.0, 79.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 113.0, 113.0, 117.0, 115.0, 114.0, 114.0, 111.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 153.0, 150.0, 149.0, 150.0, 153.0, 152.0, 150.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 98.0, 99.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 44.0, 45.0, 43.0, 45.0, 46.0, 45.0, 44.0, 44.0, 43.0], "value": 44.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 38.0, 39.0, 38.0, 39.0, 38.0, 39.0, 42.0], "value": 38.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 72.0, 73.0, 73.0, 74.0, 72.0, 77.0, 72.0, 76.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 104.0, 109.0, 123.0, 104.0, 113.0, 107.0, 114.0, 108.0], "value": 110.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 165.0, 158.0, 163.0, 162.0, 160.0, 160.0, 166.0, 157.0, 160.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 59.0, 61.0, 61.0, 59.0, 66.0, 62.0, 58.0], "value": 60.6, "unit": "score"}]}]} 06:12:03 INFO - Return code: 0 06:12:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:12:03 INFO - # TBPL SUCCESS # 06:12:03 INFO - Running post-action listener: _package_coverage_data 06:12:03 INFO - Running post-action listener: _resource_record_post_action 06:12:03 INFO - [mozharness: 2017-09-13 13:12:03.544065Z] Finished run-tests step (success) 06:12:03 INFO - Running post-run listener: _resource_record_post_run 06:12:03 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 9125888; Write bytes: 454275072; Read time: 2340; Write time: 474680 06:12:03 INFO - TinderboxPrint: CPU usage
13.1% 06:12:03 INFO - TinderboxPrint: I/O read bytes / time
9,125,888 / 2,340 06:12:03 INFO - TinderboxPrint: I/O write bytes / time
454,275,072 / 474,680 06:12:03 INFO - TinderboxPrint: CPU idle
8,240.5 (86.9%) 06:12:03 INFO - TinderboxPrint: CPU user
1,185.7 (12.5%) 06:12:03 INFO - TinderboxPrint: Swap in / out
0 / 0 06:12:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12484608; Read time: 0; Write time: 1644 06:12:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:12:03 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 7380992; Write bytes: 441790464; Read time: 2300; Write time: 473036 06:12:04 INFO - Running post-run listener: _upload_blobber_files 06:12:04 INFO - Blob upload gear active. 06:12:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:12:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:12:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:12:04 INFO - (blobuploader) - INFO - Open directory for files ... 06:12:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 06:12:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 06:12:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:05 INFO - (blobuploader) - INFO - Done attempting. 06:12:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 06:12:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 06:12:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:06 INFO - (blobuploader) - INFO - Done attempting. 06:12:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:12:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:12:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:07 INFO - (blobuploader) - INFO - Done attempting. 06:12:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:12:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:12:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:14 INFO - (blobuploader) - INFO - Done attempting. 06:12:14 INFO - (blobuploader) - INFO - Iteration through files over. 06:12:14 INFO - Return code: 0 06:12:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:12:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:12:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be064583b9c5c4c144feb43f3d68c7128cbca349a366a98dc8e4f5cf65280ecfe06245fc3c563b81249b24442ea9db47cf6ac6b368f8fa9bf9d6b7d88efcd45d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a973aab32dcd08973bf1ab63870c6ea9cd284174ec5ed422c0b083a01c7291d838a386686e0c1f509ea324a776b33d5eb523059c66d03598882d205c6300123", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bcaf25ea33a8a17f6c72975e1a9dd2a69e1d57b7a673b54dc3633c37af9cb3c417721676bd73d7255e2a75f230ab1b52d5dafdd641caf6e01bdca7772606848", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f32a937248ecb3b09fe8151d3a24cb5262195d7d1ebdb23df17792e9c952708b5f7626ef4abd9692e991abf8e580ad8ca6c3d151aa921a0c8203cfb3942d4bb"} 06:12:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:12:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:12:14 INFO - Contents: 06:12:14 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be064583b9c5c4c144feb43f3d68c7128cbca349a366a98dc8e4f5cf65280ecfe06245fc3c563b81249b24442ea9db47cf6ac6b368f8fa9bf9d6b7d88efcd45d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a973aab32dcd08973bf1ab63870c6ea9cd284174ec5ed422c0b083a01c7291d838a386686e0c1f509ea324a776b33d5eb523059c66d03598882d205c6300123", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bcaf25ea33a8a17f6c72975e1a9dd2a69e1d57b7a673b54dc3633c37af9cb3c417721676bd73d7255e2a75f230ab1b52d5dafdd641caf6e01bdca7772606848", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f32a937248ecb3b09fe8151d3a24cb5262195d7d1ebdb23df17792e9c952708b5f7626ef4abd9692e991abf8e580ad8ca6c3d151aa921a0c8203cfb3942d4bb"} 06:12:14 INFO - Running post-run listener: copy_logs_to_upload_dir 06:12:14 INFO - Copying logs to upload dir... 06:12:14 INFO - mkdir: /builds/slave/test/build/upload/logs 06:12:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.223893 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-09-13 06:12:14.402513) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 06:12:14.406508) ========= 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=652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be064583b9c5c4c144feb43f3d68c7128cbca349a366a98dc8e4f5cf65280ecfe06245fc3c563b81249b24442ea9db47cf6ac6b368f8fa9bf9d6b7d88efcd45d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a973aab32dcd08973bf1ab63870c6ea9cd284174ec5ed422c0b083a01c7291d838a386686e0c1f509ea324a776b33d5eb523059c66d03598882d205c6300123", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bcaf25ea33a8a17f6c72975e1a9dd2a69e1d57b7a673b54dc3633c37af9cb3c417721676bd73d7255e2a75f230ab1b52d5dafdd641caf6e01bdca7772606848", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f32a937248ecb3b09fe8151d3a24cb5262195d7d1ebdb23df17792e9c952708b5f7626ef4abd9692e991abf8e580ad8ca6c3d151aa921a0c8203cfb3942d4bb"} build_url:https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/MRxBWqUrQPGKnk9jTZc_NQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be064583b9c5c4c144feb43f3d68c7128cbca349a366a98dc8e4f5cf65280ecfe06245fc3c563b81249b24442ea9db47cf6ac6b368f8fa9bf9d6b7d88efcd45d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a973aab32dcd08973bf1ab63870c6ea9cd284174ec5ed422c0b083a01c7291d838a386686e0c1f509ea324a776b33d5eb523059c66d03598882d205c6300123", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bcaf25ea33a8a17f6c72975e1a9dd2a69e1d57b7a673b54dc3633c37af9cb3c417721676bd73d7255e2a75f230ab1b52d5dafdd641caf6e01bdca7772606848", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f32a937248ecb3b09fe8151d3a24cb5262195d7d1ebdb23df17792e9c952708b5f7626ef4abd9692e991abf8e580ad8ca6c3d151aa921a0c8203cfb3942d4bb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 06:12:14.436960) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 06:12:14.437348) ========= 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=652eb03db935cfc1c15ebda0000001ad-1505298298.857873-655032570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 06:12:14.520118) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 06:12:14.520414) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 06:12:14.520725) ========= ========= Total master_lag: 0.22 =========