builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1506683645.07 results: success (0) revision: 946b9c995ec331f4f96360409fd8d2fc49e46838 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 04:14:05.071627) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-29 04:14:05.072120) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 04:14:05.072391) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-29 04:14:05.091120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:14:05.091495) ========= 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=62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-29 04:14:05-- 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% 42.0M=0s 2017-09-29 04:14:05 (42.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.157529 ========= master_lag: 0.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:14:05.454098) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:14:05.459595) ========= 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=62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014294 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:14:05.516893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-29 04:14:05.517318) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 946b9c995ec331f4f96360409fd8d2fc49e46838 --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 946b9c995ec331f4f96360409fd8d2fc49e46838 --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=62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-29 04:14:05,567 truncating revision to first 12 chars 2017-09-29 04:14:05,567 Setting DEBUG logging. 2017-09-29 04:14:05,567 attempt 1/10 2017-09-29 04:14:05,567 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/946b9c995ec3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-29 04:14:06,592 unpacking tar archive at: mozilla-central-946b9c995ec3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.346254 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-29 04:14:06.888542) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 04:14:06.892090) ========= script_repo_revision: 946b9c995ec331f4f96360409fd8d2fc49e46838 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-29 04:14:06.892594) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 04:14:06.892879) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-29 04:14:06.911531) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2017-09-29 04:14:06.911966) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:14:07 INFO - MultiFileLogger online at 20170929 04:14:07 in /builds/slave/test 04:14:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:14:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:14:07 INFO - {'append_to_log': False, 04:14:07 INFO - 'base_work_dir': '/builds/slave/test', 04:14:07 INFO - 'blob_upload_branch': 'Firefox', 04:14:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:14:07 INFO - 'branch': 'Firefox', 04:14:07 INFO - 'buildbot_json_path': 'buildprops.json', 04:14:07 INFO - 'code_coverage': False, 04:14:07 INFO - 'config_files': ('talos/linux_config.py',), 04:14:07 INFO - 'default_actions': ('clobber', 04:14:07 INFO - 'read-buildbot-config', 04:14:07 INFO - 'download-and-extract', 04:14:07 INFO - 'populate-webroot', 04:14:07 INFO - 'create-virtualenv', 04:14:07 INFO - 'install', 04:14:07 INFO - 'setup-mitmproxy', 04:14:07 INFO - 'run-tests'), 04:14:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:14:07 INFO - 'disable_ccov_upload': False, 04:14:07 INFO - 'disable_stylo': False, 04:14:07 INFO - 'download_minidump_stackwalk': True, 04:14:07 INFO - 'download_symbols': 'ondemand', 04:14:07 INFO - 'enable_stylo': False, 04:14:07 INFO - 'enable_webrender': False, 04:14:07 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:14:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:14:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:14:07 INFO - 'gecko_profile': False, 04:14:07 INFO - 'gecko_profile_interval': 0, 04:14:07 INFO - 'installer_path': 'installer.exe', 04:14:07 INFO - 'log_level': 'info', 04:14:07 INFO - 'log_name': 'talos', 04:14:07 INFO - 'log_to_console': True, 04:14:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:14:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:14:07 INFO - 'opt_config_files': (), 04:14:07 INFO - 'pip_index': False, 04:14:07 INFO - 'suite': 'dromaeojs-e10s', 04:14:07 INFO - 'system_bits': '32', 04:14:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:14:07 INFO - 'title': 'talos-linux64-ix-018', 04:14:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:14:07 INFO - 'use_talos_json': True, 04:14:07 INFO - 'verify': 'False', 04:14:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:14:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:14:07 INFO - 'work_dir': 'build'} 04:14:07 INFO - [mozharness: 2017-09-29 11:14:07.097857Z] Running clobber step. 04:14:07 INFO - Running pre-action listener: _resource_record_pre_action 04:14:07 INFO - Running main action method: clobber 04:14:07 INFO - rmtree: /builds/slave/test/build 04:14:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:14:08 INFO - Running post-action listener: _resource_record_post_action 04:14:08 INFO - [mozharness: 2017-09-29 11:14:08.077777Z] Finished clobber step (success) 04:14:08 INFO - [mozharness: 2017-09-29 11:14:08.077873Z] Running read-buildbot-config step. 04:14:08 INFO - Running pre-action listener: _resource_record_pre_action 04:14:08 INFO - Running main action method: read_buildbot_config 04:14:08 INFO - Using buildbot properties: 04:14:08 INFO - { 04:14:08 INFO - "project": "", 04:14:08 INFO - "product": "firefox", 04:14:08 INFO - "who": "archaeopteryx@coole-files.de", 04:14:08 INFO - "installer_path": "public/build/target.tar.bz2", 04:14:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:14:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:14:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 04:14:08 INFO - "stage_platform": "linux64-pgo", 04:14:08 INFO - "basedir": "/builds/slave/test", 04:14:08 INFO - "buildnumber": 217, 04:14:08 INFO - "platform": "ubuntu64_hw", 04:14:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:14:08 INFO - "slavebuilddir": "test", 04:14:08 INFO - "taskId": "NoS-GYTBTf2owGpWQeUmdQ", 04:14:08 INFO - "branch": "mozilla-central", 04:14:08 INFO - "script_repo_revision": "production", 04:14:08 INFO - "revision": "946b9c995ec331f4f96360409fd8d2fc49e46838", 04:14:08 INFO - "slavename": "talos-linux64-ix-018", 04:14:08 INFO - "repo_path": "mozilla-central" 04:14:08 INFO - } 04:14:08 INFO - Finding installer, test and symbols from parent task. 04:14:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NoS-GYTBTf2owGpWQeUmdQ'}, attempt #1 04:14:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NoS-GYTBTf2owGpWQeUmdQ'}, attempt #1 04:14:09 INFO - Task dependencies: OsRU9v7_RyaOclVwZfen8Q 04:14:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q'}, attempt #1 04:14:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2 04:14:09 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.test_packages.json 04:14:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.crashreporter-symbols.zip 04:14:09 INFO - Running post-action listener: _resource_record_post_action 04:14:09 INFO - [mozharness: 2017-09-29 11:14:09.487328Z] Finished read-buildbot-config step (success) 04:14:09 INFO - [mozharness: 2017-09-29 11:14:09.487544Z] Running download-and-extract step. 04:14:09 INFO - Running pre-action listener: _resource_record_pre_action 04:14:09 INFO - Running main action method: download_and_extract 04:14:09 INFO - mkdir: /builds/slave/test/build/tests 04:14:09 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')]} 04:14:09 INFO - trying https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.test_packages.json 04:14:09 INFO - Downloading https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:14:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:14:10 INFO - Downloaded 989 bytes. 04:14:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:14:10 INFO - Using the following test package requirements: 04:14:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:14:10 INFO - u'common': [u'target.common.tests.zip'], 04:14:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:14:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:14:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:14:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:14:10 INFO - u'mozbase': [u'target.common.tests.zip'], 04:14:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:14:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:14:10 INFO - u'web-platform': [u'target.common.tests.zip', 04:14:10 INFO - u'target.web-platform.tests.tar.gz'], 04:14:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:14:10 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:14:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.common.tests.zip 04:14:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:14:10 INFO - Fetch https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.common.tests.zip into memory 04:14:11 INFO - Content-Length response header: 55920898 04:14:11 INFO - Bytes received: 55920898 04:14:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.talos.tests.zip 04:14:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:14:21 INFO - Fetch https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.talos.tests.zip into memory 04:14:22 INFO - Content-Length response header: 14521355 04:14:22 INFO - Bytes received: 14521355 04:14:22 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')]} 04:14:22 INFO - trying https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2 04:14:22 INFO - Downloading https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:14:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:14:24 INFO - Downloaded 62364334 bytes. 04:14:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2 04:14:24 INFO - mkdir: /builds/slave/test/properties 04:14:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:14:24 INFO - Writing to file /builds/slave/test/properties/build_url 04:14:24 INFO - Contents: 04:14:24 INFO - build_url:https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2 04:14:24 INFO - Running post-action listener: _resource_record_post_action 04:14:24 INFO - Running post-action listener: find_tests_for_verification 04:14:24 INFO - Running post-action listener: set_extra_try_arguments 04:14:24 INFO - [mozharness: 2017-09-29 11:14:24.068144Z] Finished download-and-extract step (success) 04:14:24 INFO - [mozharness: 2017-09-29 11:14:24.068300Z] Running populate-webroot step. 04:14:24 INFO - Running pre-action listener: _resource_record_pre_action 04:14:24 INFO - Running main action method: populate_webroot 04:14:24 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:14:24 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:24 INFO - 'tests': ['tresize', 04:14:24 INFO - 'tcanvasmark']}, 04:14:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:14:24 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:24 INFO - 'tests': ['dromaeo_css', 04:14:24 INFO - 'kraken']}, 04:14:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:14:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:24 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:14:24 INFO - 'talos_options': ['--disable-stylo'], 04:14:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:14:24 INFO - 'tests': ['damp', 'tps']}, 04:14:24 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:14:24 INFO - 'talos_options': ['--disable-stylo'], 04:14:24 INFO - 'tests': ['damp', 'tps']}, 04:14:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:14:24 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:24 INFO - 'tests': ['dromaeo_dom']}, 04:14:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:14:24 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:24 INFO - 'tests': ['basic_compositor_video', 04:14:24 INFO - 'glvideo']}, 04:14:24 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:14:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:14:24 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:14:24 INFO - 'talos_options': ['--disable-stylo'], 04:14:24 INFO - 'tests': ['ts_paint_webext', 04:14:24 INFO - 'tp5o_webext']}, 04:14:24 INFO - 'other-e10s': {'tests': ['a11yr', 04:14:24 INFO - 'ts_paint', 04:14:24 INFO - 'tpaint', 04:14:24 INFO - 'sessionrestore', 04:14:24 INFO - 'sessionrestore_many_windows', 04:14:24 INFO - 'sessionrestore_no_auto_restore', 04:14:24 INFO - 'tabpaint', 04:14:24 INFO - 'cpstartup']}, 04:14:24 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:24 INFO - 'tests': ['a11yr', 04:14:24 INFO - 'ts_paint', 04:14:24 INFO - 'tpaint', 04:14:24 INFO - 'sessionrestore', 04:14:24 INFO - 'sessionrestore_many_windows', 04:14:24 INFO - 'sessionrestore_no_auto_restore', 04:14:24 INFO - 'tabpaint', 04:14:24 INFO - 'cpstartup']}, 04:14:24 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 04:14:24 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:14:24 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:24 INFO - 'tests': ['perf_reftest_singletons']}, 04:14:24 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:24 INFO - 'tests': ['perf_reftest']}, 04:14:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:14:24 INFO - 'tsvgr_opacity', 04:14:24 INFO - 'tart', 04:14:24 INFO - 'tscrollx', 04:14:24 INFO - 'tsvg_static']}, 04:14:24 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:14:24 INFO - 'tests': ['tsvgx', 04:14:24 INFO - 'tsvgr_opacity', 04:14:24 INFO - 'tart', 04:14:24 INFO - 'tscrollx', 04:14:24 INFO - 'tsvg_static']}, 04:14:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:14:24 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:14:24 INFO - 'talos_options': ['--disable-stylo'], 04:14:24 INFO - 'tests': ['tp5o']}, 04:14:24 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:14:24 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:14:24 INFO - 'talos_options': ['--mitmproxy', 04:14:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:14:24 INFO - '--firstNonBlankPaint'], 04:14:24 INFO - 'tests': ['tp6_google', 04:14:24 INFO - 'tp6_youtube', 04:14:24 INFO - 'tp6_amazon', 04:14:24 INFO - 'tp6_facebook']}, 04:14:24 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:14:24 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:14:24 INFO - 'talos_options': ['--disable-stylo', 04:14:24 INFO - '--mitmproxy', 04:14:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:14:24 INFO - '--firstNonBlankPaint'], 04:14:24 INFO - 'tests': ['tp6_google', 04:14:24 INFO - 'tp6_youtube', 04:14:24 INFO - 'tp6_amazon', 04:14:24 INFO - 'tp6_facebook']}, 04:14:24 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:14:24 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:14:24 INFO - 'talos_options': ['--stylo-threads=1', 04:14:24 INFO - '--mitmproxy', 04:14:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:14:24 INFO - '--firstNonBlankPaint'], 04:14:24 INFO - 'tests': ['tp6_google', 04:14:24 INFO - 'tp6_youtube', 04:14:24 INFO - 'tp6_amazon', 04:14:24 INFO - 'tp6_facebook']}, 04:14:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:14:24 INFO - 'talos_options': ['--xperf_path', 04:14:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:24 INFO - 'tests': ['tp5n']}, 04:14:24 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:14:24 INFO - 'talos_options': ['--disable-stylo', 04:14:24 INFO - '--xperf_path', 04:14:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:24 INFO - 'tests': ['tp5n']}}} 04:14:24 INFO - Running post-action listener: _resource_record_post_action 04:14:24 INFO - [mozharness: 2017-09-29 11:14:24.352576Z] Finished populate-webroot step (success) 04:14:24 INFO - [mozharness: 2017-09-29 11:14:24.352671Z] Running create-virtualenv step. 04:14:24 INFO - Running pre-action listener: _resource_record_pre_action 04:14:24 INFO - Running main action method: create_virtualenv 04:14:24 INFO - Creating virtualenv /builds/slave/test/build/venv 04:14:24 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:14:24 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:14:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:14:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:14:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:14:24 INFO - Installing distribute.............................................................................................................................................................................................done. 04:14:25 INFO - Installing pip...............done. 04:14:25 INFO - Return code: 0 04:14:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:14:25 INFO - Reading from file tmpfile_stdout 04:14:25 INFO - Output received: 04:14:25 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:14:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:14:25 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')]} 04:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:25 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')]} 04:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:25 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 0x20cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2436d60>, '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 0x2437a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2437ef0>, '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': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', '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 04:14:25 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 04:14:25 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 04:14:25 INFO - Using env: {'DISPLAY': ':0', 04:14:25 INFO - 'HOME': '/home/cltbld', 04:14:25 INFO - 'LANG': 'en_US.UTF-8', 04:14:25 INFO - 'LANGUAGE': 'en_US:en', 04:14:25 INFO - 'LOGNAME': 'cltbld', 04:14:25 INFO - 'MAIL': '/var/mail/cltbld', 04:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:25 INFO - 'MOZ_NO_REMOTE': '1', 04:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:25 INFO - 'NO_EM_RESTART': '1', 04:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:25 INFO - 'PWD': '/builds/slave/test', 04:14:25 INFO - 'SHELL': '/bin/bash', 04:14:25 INFO - 'SHLVL': '1', 04:14:25 INFO - 'TERM': 'linux', 04:14:25 INFO - 'TMOUT': '86400', 04:14:25 INFO - 'USER': 'cltbld', 04:14:25 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', 04:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:25 INFO - '_': '/tools/buildbot/bin/python'} 04:14:26 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:14:26 INFO - Downloading/unpacking pip>=1.5 04:14:26 INFO - Running setup.py egg_info for package pip 04:14:26 INFO - warning: no files found matching 'pip/cacert.pem' 04:14:26 INFO - warning: no files found matching '*.html' under directory 'docs' 04:14:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:14:26 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:14:26 INFO - Installing collected packages: pip 04:14:26 INFO - Found existing installation: pip 1.1 04:14:26 INFO - Uninstalling pip: 04:14:26 INFO - Successfully uninstalled pip 04:14:26 INFO - Running setup.py install for pip 04:14:26 INFO - warning: no files found matching 'pip/cacert.pem' 04:14:26 INFO - warning: no files found matching '*.html' under directory 'docs' 04:14:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:14:26 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:14:26 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:14:26 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:14:26 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:14:26 INFO - Successfully installed pip 04:14:26 INFO - Cleaning up... 04:14:26 INFO - Return code: 0 04:14:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:14:26 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')]} 04:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:26 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')]} 04:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:26 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 0x20cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2436d60>, '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 0x2437a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2437ef0>, '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': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', '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 04:14:26 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 04:14:26 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 04:14:26 INFO - Using env: {'DISPLAY': ':0', 04:14:26 INFO - 'HOME': '/home/cltbld', 04:14:26 INFO - 'LANG': 'en_US.UTF-8', 04:14:26 INFO - 'LANGUAGE': 'en_US:en', 04:14:26 INFO - 'LOGNAME': 'cltbld', 04:14:26 INFO - 'MAIL': '/var/mail/cltbld', 04:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:26 INFO - 'MOZ_NO_REMOTE': '1', 04:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:26 INFO - 'NO_EM_RESTART': '1', 04:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:26 INFO - 'PWD': '/builds/slave/test', 04:14:26 INFO - 'SHELL': '/bin/bash', 04:14:26 INFO - 'SHLVL': '1', 04:14:26 INFO - 'TERM': 'linux', 04:14:26 INFO - 'TMOUT': '86400', 04:14:26 INFO - 'USER': 'cltbld', 04:14:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', 04:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:26 INFO - '_': '/tools/buildbot/bin/python'} 04:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:26 INFO - Downloading/unpacking psutil>=3.1.1 04:14:26 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 04:14:26 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 04:14:26 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 04:14:26 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 04:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:14:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:27 INFO - Installing collected packages: psutil 04:14:27 INFO - Running setup.py install for psutil 04:14:28 INFO - building 'psutil._psutil_linux' extension 04:14:28 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 04:14:28 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 04:14:28 INFO - building 'psutil._psutil_posix' extension 04:14:28 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 04:14:28 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 04:14:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:28 INFO - Successfully installed psutil 04:14:28 INFO - Cleaning up... 04:14:28 INFO - Return code: 0 04:14:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:14:28 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')]} 04:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:28 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')]} 04:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:28 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 0x20cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2436d60>, '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 0x2437a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2437ef0>, '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': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', '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 04:14:28 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 04:14:28 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 04:14:28 INFO - Using env: {'DISPLAY': ':0', 04:14:28 INFO - 'HOME': '/home/cltbld', 04:14:28 INFO - 'LANG': 'en_US.UTF-8', 04:14:28 INFO - 'LANGUAGE': 'en_US:en', 04:14:28 INFO - 'LOGNAME': 'cltbld', 04:14:28 INFO - 'MAIL': '/var/mail/cltbld', 04:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:28 INFO - 'MOZ_NO_REMOTE': '1', 04:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:28 INFO - 'NO_EM_RESTART': '1', 04:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:28 INFO - 'PWD': '/builds/slave/test', 04:14:28 INFO - 'SHELL': '/bin/bash', 04:14:28 INFO - 'SHLVL': '1', 04:14:28 INFO - 'TERM': 'linux', 04:14:28 INFO - 'TMOUT': '86400', 04:14:28 INFO - 'USER': 'cltbld', 04:14:28 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', 04:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:28 INFO - '_': '/tools/buildbot/bin/python'} 04:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:14:28 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 04:14:28 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 04:14:28 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 04:14:28 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 04:14:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:14:29 INFO - Installing collected packages: mozsystemmonitor 04:14:29 INFO - Running setup.py install for mozsystemmonitor 04:14:30 INFO - Successfully installed mozsystemmonitor 04:14:30 INFO - Cleaning up... 04:14:30 INFO - Return code: 0 04:14:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:14:30 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')]} 04:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:30 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')]} 04:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:30 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 0x20cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2436d60>, '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 0x2437a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2437ef0>, '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': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', '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 04:14:30 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 04:14:30 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 04:14:30 INFO - Using env: {'DISPLAY': ':0', 04:14:30 INFO - 'HOME': '/home/cltbld', 04:14:30 INFO - 'LANG': 'en_US.UTF-8', 04:14:30 INFO - 'LANGUAGE': 'en_US:en', 04:14:30 INFO - 'LOGNAME': 'cltbld', 04:14:30 INFO - 'MAIL': '/var/mail/cltbld', 04:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:30 INFO - 'MOZ_NO_REMOTE': '1', 04:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:30 INFO - 'NO_EM_RESTART': '1', 04:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:30 INFO - 'PWD': '/builds/slave/test', 04:14:30 INFO - 'SHELL': '/bin/bash', 04:14:30 INFO - 'SHLVL': '1', 04:14:30 INFO - 'TERM': 'linux', 04:14:30 INFO - 'TMOUT': '86400', 04:14:30 INFO - 'USER': 'cltbld', 04:14:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', 04:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:30 INFO - '_': '/tools/buildbot/bin/python'} 04:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:31 INFO - Downloading/unpacking jsonschema==2.5.1 04:14:31 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 04:14:31 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 04:14:31 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 04:14:31 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 04:14:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:14:32 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 04:14:32 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 04:14:32 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 04:14:32 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 04:14:32 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:32 INFO - warning: no files found matching '*.txt' 04:14:32 INFO - no previously-included directories found matching 'build' 04:14:32 INFO - no previously-included directories found matching 'dist' 04:14:32 INFO - no previously-included directories found matching '.git*' 04:14:32 INFO - Installing collected packages: jsonschema, functools32 04:14:32 INFO - Running setup.py install for functools32 04:14:32 INFO - warning: no files found matching '*.txt' 04:14:32 INFO - no previously-included directories found matching 'build' 04:14:32 INFO - no previously-included directories found matching 'dist' 04:14:32 INFO - no previously-included directories found matching '.git*' 04:14:32 INFO - Successfully installed jsonschema functools32 04:14:32 INFO - Cleaning up... 04:14:32 INFO - Return code: 0 04:14:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14: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')]} 04:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:32 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 0x20cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2436d60>, '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 0x2437a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2437ef0>, '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': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', '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 04:14:32 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 04:14:32 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 04:14:32 INFO - Using env: {'DISPLAY': ':0', 04:14:32 INFO - 'HOME': '/home/cltbld', 04:14:32 INFO - 'LANG': 'en_US.UTF-8', 04:14:32 INFO - 'LANGUAGE': 'en_US:en', 04:14:32 INFO - 'LOGNAME': 'cltbld', 04:14:32 INFO - 'MAIL': '/var/mail/cltbld', 04:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:32 INFO - 'MOZ_NO_REMOTE': '1', 04:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:32 INFO - 'NO_EM_RESTART': '1', 04:14:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:32 INFO - 'PWD': '/builds/slave/test', 04:14:32 INFO - 'SHELL': '/bin/bash', 04:14:32 INFO - 'SHLVL': '1', 04:14:32 INFO - 'TERM': 'linux', 04:14:32 INFO - 'TMOUT': '86400', 04:14:32 INFO - 'USER': 'cltbld', 04:14:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', 04:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:32 INFO - '_': '/tools/buildbot/bin/python'} 04:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:14:32 INFO - Cleaning up... 04:14:32 INFO - Return code: 0 04:14:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14: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')]} 04:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:32 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 0x20cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2436d60>, '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 0x2437a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2437ef0>, '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': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', '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 04:14:32 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 04:14:32 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 04:14:32 INFO - Using env: {'DISPLAY': ':0', 04:14:32 INFO - 'HOME': '/home/cltbld', 04:14:32 INFO - 'LANG': 'en_US.UTF-8', 04:14:32 INFO - 'LANGUAGE': 'en_US:en', 04:14:32 INFO - 'LOGNAME': 'cltbld', 04:14:32 INFO - 'MAIL': '/var/mail/cltbld', 04:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:32 INFO - 'MOZ_NO_REMOTE': '1', 04:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:32 INFO - 'NO_EM_RESTART': '1', 04:14:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:32 INFO - 'PWD': '/builds/slave/test', 04:14:32 INFO - 'SHELL': '/bin/bash', 04:14:32 INFO - 'SHLVL': '1', 04:14:32 INFO - 'TERM': 'linux', 04:14:32 INFO - 'TMOUT': '86400', 04:14:32 INFO - 'USER': 'cltbld', 04:14:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', 04:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:32 INFO - '_': '/tools/buildbot/bin/python'} 04:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:33 INFO - Downloading/unpacking blobuploader==1.2.4 04:14:33 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 04:14:33 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 04:14:33 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 04:14:33 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 04:14:34 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14:34 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 04:14:34 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 04:14:34 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 04:14:34 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 04:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:34 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 04:14:34 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 04:14:34 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 04:14:34 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 04:14:34 INFO - Downloading docopt-0.6.1.tar.gz 04:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:34 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:34 INFO - Running setup.py install for blobuploader 04:14:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:35 INFO - Running setup.py install for requests 04:14:35 INFO - Running setup.py install for docopt 04:14:35 INFO - Successfully installed blobuploader requests docopt 04:14:35 INFO - Cleaning up... 04:14:35 INFO - Return code: 0 04:14:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14: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')]} 04:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:35 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 0x20cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2436d60>, '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 0x2437a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2437ef0>, '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': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', '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 04:14:35 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 04:14:35 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 04:14:35 INFO - Using env: {'DISPLAY': ':0', 04:14:35 INFO - 'HOME': '/home/cltbld', 04:14:35 INFO - 'LANG': 'en_US.UTF-8', 04:14:35 INFO - 'LANGUAGE': 'en_US:en', 04:14:35 INFO - 'LOGNAME': 'cltbld', 04:14:35 INFO - 'MAIL': '/var/mail/cltbld', 04:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:35 INFO - 'MOZ_NO_REMOTE': '1', 04:14:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:35 INFO - 'NO_EM_RESTART': '1', 04:14:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:35 INFO - 'PWD': '/builds/slave/test', 04:14:35 INFO - 'SHELL': '/bin/bash', 04:14:35 INFO - 'SHLVL': '1', 04:14:35 INFO - 'TERM': 'linux', 04:14:35 INFO - 'TMOUT': '86400', 04:14:35 INFO - 'USER': 'cltbld', 04:14:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', 04:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:35 INFO - '_': '/tools/buildbot/bin/python'} 04:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:35 INFO - Running setup.py (path:/tmp/pip-D08O6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:35 INFO - Running setup.py (path:/tmp/pip-JgVMlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:35 INFO - Running setup.py (path:/tmp/pip-4ctXLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:35 INFO - Running setup.py (path:/tmp/pip-y2fdIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:36 INFO - Running setup.py (path:/tmp/pip-DOI2Ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:36 INFO - Running setup.py (path:/tmp/pip-b7PS5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:36 INFO - Running setup.py (path:/tmp/pip-ed8I_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:36 INFO - Running setup.py (path:/tmp/pip-iFRe8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:36 INFO - Running setup.py (path:/tmp/pip-_788X0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:36 INFO - Running setup.py (path:/tmp/pip-vrmr5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:36 INFO - Running setup.py (path:/tmp/pip-Qh1SJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:36 INFO - Running setup.py (path:/tmp/pip-uep80v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:36 INFO - Running setup.py (path:/tmp/pip-lIMYXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:36 INFO - Running setup.py (path:/tmp/pip-1XSIGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:36 INFO - Running setup.py (path:/tmp/pip-PePiJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:36 INFO - Running setup.py (path:/tmp/pip-SW56nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:36 INFO - Running setup.py (path:/tmp/pip-m1mmpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:36 INFO - Running setup.py install for manifestparser 04:14:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:37 INFO - Running setup.py install for mozcrash 04:14:37 INFO - Running setup.py install for mozdebug 04:14:37 INFO - Running setup.py install for mozdevice 04:14:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:37 INFO - Running setup.py install for mozfile 04:14:37 INFO - Running setup.py install for mozhttpd 04:14:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:37 INFO - Running setup.py install for mozinfo 04:14:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:37 INFO - Running setup.py install for mozInstall 04:14:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:37 INFO - Running setup.py install for mozleak 04:14:37 INFO - Running setup.py install for mozlog 04:14:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:37 INFO - Running setup.py install for moznetwork 04:14:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:38 INFO - Running setup.py install for mozprocess 04:14:38 INFO - Running setup.py install for mozprofile 04:14:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:38 INFO - Running setup.py install for mozrunner 04:14:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:38 INFO - Running setup.py install for mozscreenshot 04:14:38 INFO - Running setup.py install for moztest 04:14:38 INFO - Running setup.py install for mozversion 04:14:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:38 INFO - Cleaning up... 04:14:38 INFO - Return code: 0 04:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:38 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')]} 04:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:38 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')]} 04:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:38 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 0x20cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2436d60>, '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 0x2437a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2437ef0>, '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': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', '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 04:14:38 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 04:14:38 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 04:14:38 INFO - Using env: {'DISPLAY': ':0', 04:14:38 INFO - 'HOME': '/home/cltbld', 04:14:38 INFO - 'LANG': 'en_US.UTF-8', 04:14:38 INFO - 'LANGUAGE': 'en_US:en', 04:14:38 INFO - 'LOGNAME': 'cltbld', 04:14:38 INFO - 'MAIL': '/var/mail/cltbld', 04:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:38 INFO - 'MOZ_NO_REMOTE': '1', 04:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:38 INFO - 'NO_EM_RESTART': '1', 04:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:38 INFO - 'PWD': '/builds/slave/test', 04:14:38 INFO - 'SHELL': '/bin/bash', 04:14:38 INFO - 'SHLVL': '1', 04:14:38 INFO - 'TERM': 'linux', 04:14:38 INFO - 'TMOUT': '86400', 04:14:38 INFO - 'USER': 'cltbld', 04:14:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', 04:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:38 INFO - '_': '/tools/buildbot/bin/python'} 04:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:38 INFO - Running setup.py (path:/tmp/pip-LEn42s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:38 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)) 04:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:38 INFO - Running setup.py (path:/tmp/pip-ShBscS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:39 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)) 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:39 INFO - Running setup.py (path:/tmp/pip-gQCXgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:39 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)) 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:39 INFO - Running setup.py (path:/tmp/pip-EbPUZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:39 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)) 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:39 INFO - Running setup.py (path:/tmp/pip-UOYJ6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:39 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)) 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:39 INFO - Running setup.py (path:/tmp/pip-P9KVUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:39 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)) 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:39 INFO - Running setup.py (path:/tmp/pip-hOIhy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:39 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)) 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:39 INFO - Running setup.py (path:/tmp/pip-IbZDZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:39 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)) 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:39 INFO - Running setup.py (path:/tmp/pip-pRMbHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:39 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)) 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:39 INFO - Running setup.py (path:/tmp/pip-SOPERR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:39 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)) 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:39 INFO - Running setup.py (path:/tmp/pip-T_taEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:39 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)) 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:39 INFO - Running setup.py (path:/tmp/pip-V9jXVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:39 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)) 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:39 INFO - Running setup.py (path:/tmp/pip-DuUaF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:39 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)) 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:39 INFO - Running setup.py (path:/tmp/pip-yy0NCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:39 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)) 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:39 INFO - Running setup.py (path:/tmp/pip-t5lfRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:39 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)) 04:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:39 INFO - Running setup.py (path:/tmp/pip-ow5Quj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:40 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)) 04:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:40 INFO - Running setup.py (path:/tmp/pip-LgeuN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:40 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)) 04:14:40 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)) 04:14:40 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)) 04:14:40 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)) 04:14:40 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)) 04:14:40 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)) 04:14:40 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)) 04:14:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:41 INFO - Downloading blessings-1.6.tar.gz 04:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:41 INFO - Installing collected packages: blessings 04:14:41 INFO - Running setup.py install for blessings 04:14:41 INFO - Successfully installed blessings 04:14:41 INFO - Cleaning up... 04:14:41 INFO - Return code: 0 04:14:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:41 INFO - Reading from file tmpfile_stdout 04:14:41 INFO - Current package versions: 04:14:41 INFO - argparse == 1.2.1 04:14:41 INFO - blessings == 1.6 04:14:41 INFO - blobuploader == 1.2.4 04:14:41 INFO - docopt == 0.6.1 04:14:41 INFO - functools32 == 3.2.3-2 04:14:41 INFO - jsonschema == 2.5.1 04:14:41 INFO - manifestparser == 1.1 04:14:41 INFO - mozInstall == 1.13 04:14:41 INFO - mozcrash == 1.0 04:14:41 INFO - mozdebug == 0.1 04:14:41 INFO - mozdevice == 0.51 04:14:41 INFO - mozfile == 1.2 04:14:41 INFO - mozhttpd == 0.7 04:14:41 INFO - mozinfo == 0.10 04:14:41 INFO - mozleak == 0.1 04:14:41 INFO - mozlog == 3.5 04:14:41 INFO - moznetwork == 0.27 04:14:41 INFO - mozprocess == 0.25 04:14:41 INFO - mozprofile == 0.28 04:14:41 INFO - mozrunner == 6.13 04:14:41 INFO - mozscreenshot == 0.1 04:14:41 INFO - mozsystemmonitor == 0.3 04:14:41 INFO - moztest == 0.8 04:14:41 INFO - mozversion == 1.4 04:14:41 INFO - psutil == 3.1.1 04:14:41 INFO - requests == 1.2.3 04:14:41 INFO - wsgiref == 0.1.2 04:14:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:41 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')]} 04:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:41 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')]} 04:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:41 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 0x20cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2436d60>, '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 0x2437a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2437ef0>, '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': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', '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 04:14:41 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 04:14:41 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 04:14:41 INFO - Using env: {'DISPLAY': ':0', 04:14:41 INFO - 'HOME': '/home/cltbld', 04:14:41 INFO - 'LANG': 'en_US.UTF-8', 04:14:41 INFO - 'LANGUAGE': 'en_US:en', 04:14:41 INFO - 'LOGNAME': 'cltbld', 04:14:41 INFO - 'MAIL': '/var/mail/cltbld', 04:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:41 INFO - 'MOZ_NO_REMOTE': '1', 04:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:41 INFO - 'NO_EM_RESTART': '1', 04:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:41 INFO - 'PWD': '/builds/slave/test', 04:14:41 INFO - 'SHELL': '/bin/bash', 04:14:41 INFO - 'SHLVL': '1', 04:14:41 INFO - 'TERM': 'linux', 04:14:41 INFO - 'TMOUT': '86400', 04:14:41 INFO - 'USER': 'cltbld', 04:14:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', 04:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:41 INFO - '_': '/tools/buildbot/bin/python'} 04:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 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)) 04:14:41 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:14:43 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)) 04:14:43 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)) 04:14:43 INFO - Installing collected packages: simplejson 04:14:43 INFO - Running setup.py install for simplejson 04:14:43 INFO - building 'simplejson._speedups' extension 04:14:43 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 04:14:43 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 04:14:44 INFO - Successfully installed simplejson 04:14:44 INFO - Cleaning up... 04:14:44 INFO - Return code: 0 04:14:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2294b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24399c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2436d60>, '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 0x2437a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2437ef0>, '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': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', '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 04:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:14:44 INFO - Using env: {'DISPLAY': ':0', 04:14:44 INFO - 'HOME': '/home/cltbld', 04:14:44 INFO - 'LANG': 'en_US.UTF-8', 04:14:44 INFO - 'LANGUAGE': 'en_US:en', 04:14:44 INFO - 'LOGNAME': 'cltbld', 04:14:44 INFO - 'MAIL': '/var/mail/cltbld', 04:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:44 INFO - 'MOZ_NO_REMOTE': '1', 04:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:44 INFO - 'NO_EM_RESTART': '1', 04:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:44 INFO - 'PWD': '/builds/slave/test', 04:14:44 INFO - 'SHELL': '/bin/bash', 04:14:44 INFO - 'SHLVL': '1', 04:14:44 INFO - 'TERM': 'linux', 04:14:44 INFO - 'TMOUT': '86400', 04:14:44 INFO - 'USER': 'cltbld', 04:14:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', 04:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:44 INFO - '_': '/tools/buildbot/bin/python'} 04:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:14:44 INFO - Cleaning up... 04:14:44 INFO - Return code: 0 04:14:44 INFO - Running post-action listener: _resource_record_post_action 04:14:44 INFO - Running post-action listener: _start_resource_monitoring 04:14:44 INFO - Starting resource monitoring. 04:14:44 INFO - [mozharness: 2017-09-29 11:14:44.380713Z] Finished create-virtualenv step (success) 04:14:44 INFO - [mozharness: 2017-09-29 11:14:44.381233Z] Running install step. 04:14:44 INFO - Running pre-action listener: _resource_record_pre_action 04:14:44 INFO - Running main action method: install 04:14:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:44 INFO - Reading from file tmpfile_stdout 04:14:44 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:44 INFO - Reading from file tmpfile_stdout 04:14:44 INFO - Output received: 04:14:44 INFO - Usage: mozinstall [options] installer 04:14:44 INFO - Options: 04:14:44 INFO - -h, --help show this help message and exit 04:14:44 INFO - -d DEST, --destination=DEST 04:14:44 INFO - Directory to install application into. [default: 04:14:44 INFO - "/builds/slave/test"] 04:14:44 INFO - --app=APP Application being installed. [default: firefox] 04:14:44 INFO - mkdir: /builds/slave/test/build/application 04:14:44 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'] 04:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:15:02 INFO - Reading from file tmpfile_stdout 04:15:02 INFO - Output received: 04:15:02 INFO - /builds/slave/test/build/application/firefox/firefox 04:15:02 INFO - Running post-action listener: _resource_record_post_action 04:15:02 INFO - [mozharness: 2017-09-29 11:15:02.335972Z] Finished install step (success) 04:15:02 INFO - [mozharness: 2017-09-29 11:15:02.336222Z] Running setup-mitmproxy step. 04:15:02 INFO - Running pre-action listener: _resource_record_pre_action 04:15:02 INFO - Running main action method: setup_mitmproxy 04:15:02 INFO - Skipping: mitmproxy is not required 04:15:02 INFO - Running post-action listener: _resource_record_post_action 04:15:02 INFO - [mozharness: 2017-09-29 11:15:02.337392Z] Finished setup-mitmproxy step (success) 04:15:02 INFO - [mozharness: 2017-09-29 11:15:02.337634Z] Running run-tests step. 04:15:02 INFO - Running pre-action listener: _resource_record_pre_action 04:15:02 INFO - Running pre-action listener: _set_gcov_prefix 04:15:02 INFO - Running main action method: run_tests 04:15:02 WARNING - Try message not found. 04:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:15:02 INFO - Python 2.7.3 04:15:02 INFO - Return code: 0 04:15:02 INFO - grabbing minidump binary from tooltool 04:15: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')]} 04:15:02 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 0x2436d60>, '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 0x2437a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2437ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:15:02 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 04:15:02 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 04:15:02 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 04:15:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:15:02 INFO - Return code: 0 04:15:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:15:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:15:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:15:02 INFO - ENV: RUST_BACKTRACE is now full 04:15:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:15:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:15:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:15:02 INFO - Using env: {'DISPLAY': ':0', 04:15:02 INFO - 'HOME': '/home/cltbld', 04:15:02 INFO - 'LANG': 'en_US.UTF-8', 04:15:02 INFO - 'LANGUAGE': 'en_US:en', 04:15:02 INFO - 'LOGNAME': 'cltbld', 04:15:02 INFO - 'MAIL': '/var/mail/cltbld', 04:15:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:15:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:02 INFO - 'MOZ_NO_REMOTE': '1', 04:15:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:02 INFO - 'NO_EM_RESTART': '1', 04:15:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:02 INFO - 'PWD': '/builds/slave/test', 04:15:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:15:02 INFO - 'RUST_BACKTRACE': 'full', 04:15:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:15:02 INFO - 'SHELL': '/bin/bash', 04:15:02 INFO - 'SHLVL': '1', 04:15:02 INFO - 'TERM': 'linux', 04:15:02 INFO - 'TMOUT': '86400', 04:15:02 INFO - 'USER': 'cltbld', 04:15:02 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', 04:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:02 INFO - '_': '/tools/buildbot/bin/python'} 04:15:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:15:02 INFO - mozversion application_buildid: 20170929094722 04:15:02 INFO - mozversion application_changeset: 946b9c995ec331f4f96360409fd8d2fc49e46838 04:15:02 INFO - mozversion application_display_name: Nightly 04:15:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:15:02 INFO - mozversion application_name: Firefox 04:15:02 INFO - mozversion application_remotingname: firefox 04:15:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:15:02 INFO - mozversion application_vendor: Mozilla 04:15:02 INFO - mozversion application_version: 58.0a1 04:15:02 INFO - mozversion platform_buildid: 20170929094722 04:15:02 INFO - mozversion platform_changeset: 946b9c995ec331f4f96360409fd8d2fc49e46838 04:15:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:15:02 INFO - mozversion platform_version: 58.0a1 04:15:02 INFO - using testdate: 1506683702 04:15:02 INFO - actual date: 1506683702 04:15:02 INFO - starting webserver on 'localhost:36759' 04:15:02 INFO - SUITE-START | Running 2 tests 04:15:02 INFO - TEST-START | dromaeo_css 04:15:02 INFO - Initialising browser for dromaeo_css test... 04:15:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36759/getInfo.html -profile /tmp/tmpfRSZk7/profile 04:15:02 INFO - TEST-INFO | started process 20314 (/builds/slave/test/build/application/firefox/firefox http://localhost:36759/getInfo.html) 04:15:07 INFO - TEST-INFO | 20314: exit 0 04:15:07 INFO - Browser initialized. 04:15:07 INFO - Running cycle 1/1 for dromaeo_css test... 04:15:07 INFO - Using env: {'DISPLAY': ':0', 04:15:07 INFO - 'HOME': '/home/cltbld', 04:15:07 INFO - 'JSGC_DISABLE_POISONING': '1', 04:15:07 INFO - 'LANG': 'en_US.UTF-8', 04:15:07 INFO - 'LANGUAGE': 'en_US:en', 04:15:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:15:07 INFO - 'LOGNAME': 'cltbld', 04:15:07 INFO - 'MAIL': '/var/mail/cltbld', 04:15:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:15:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:15:07 INFO - 'MOZ_CRASHREPORTER': '1', 04:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:15:07 INFO - 'MOZ_NO_REMOTE': '1', 04:15:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:07 INFO - 'NO_EM_RESTART': '1', 04:15:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:07 INFO - 'PWD': '/builds/slave/test', 04:15:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:15:07 INFO - 'RUST_BACKTRACE': 'full', 04:15:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:15:07 INFO - 'SHELL': '/bin/bash', 04:15:07 INFO - 'SHLVL': '1', 04:15:07 INFO - 'TERM': 'linux', 04:15:07 INFO - 'TMOUT': '86400', 04:15:07 INFO - 'USER': 'cltbld', 04:15:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', 04:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:07 INFO - '_': '/tools/buildbot/bin/python'} 04:15:07 INFO - TEST-INFO | started process 20548 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfRSZk7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:08 INFO - PID 20548 | 04:15:08 INFO - PID 20548 | (/builds/slave/test/build/application/firefox/firefox:20598): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:15:08 INFO - PID 20548 | 04:15:18 INFO - PID 20548 | RSS: Main: 144637952 04:15:18 INFO - PID 20548 | 04:18:15 INFO - PID 20548 | Cycle 1(1): loaded http://localhost:36759/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36759/tests/dromaeo/cssquery-ext.html) 04:18:16 INFO - PID 20548 | RSS: Main: 143351808 04:18:16 INFO - PID 20548 | 04:21:18 INFO - PID 20548 | Cycle 1(1): loaded http://localhost:36759/tests/dromaeo/cssquery-ext.html (next: http://localhost:36759/tests/dromaeo/cssquery-jquery.html) 04:21:18 INFO - PID 20548 | RSS: Main: 143695872 04:21:18 INFO - PID 20548 | 04:24:20 INFO - PID 20548 | Cycle 1(1): loaded http://localhost:36759/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36759/tests/dromaeo/cssquery-mootools.html) 04:24:20 INFO - PID 20548 | RSS: Main: 144814080 04:24:20 INFO - PID 20548 | 04:27:22 INFO - PID 20548 | Cycle 1(1): loaded http://localhost:36759/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36759/tests/dromaeo/cssquery-prototype.html) 04:27:23 INFO - PID 20548 | RSS: Main: 144805888 04:27:23 INFO - PID 20548 | 04:30:26 INFO - PID 20548 | Cycle 1(1): loaded http://localhost:36759/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36759/tests/dromaeo/cssquery-yui.html) 04:30:26 INFO - PID 20548 | RSS: Main: 147730432 04:30:26 INFO - PID 20548 | 04:33:28 INFO - PID 20548 | Cycle 1(1): loaded http://localhost:36759/tests/dromaeo/cssquery-yui.html (next: http://localhost:36759/tests/dromaeo/cssquery-dojo.html) 04:33:28 INFO - PID 20548 | RSS: Main: 146997248 04:33:28 INFO - PID 20548 | 04:33:28 INFO - PID 20548 | __start_tp_report 04:33:28 INFO - PID 20548 | _x_x_mozilla_page_load 04:33:28 INFO - PID 20548 | _x_x_mozilla_page_load_details 04:33:28 INFO - PID 20548 | |i|pagename|runs| 04:33:28 INFO - PID 20548 | |0;dojo.html;3895.5909629488906;3902.9804850975743;3913.452116703662;3920.039590300377;3922.490076290082;6017.939820601792;6172.5370597205165;6239.313675495698;6270.27891792444;6328.557001009931;6217.160683307752;6251.906221406683;6270.27891792444;6272.153259309992;6282.0576913463;5526.778928842841;5597.552195824324;5603.46767057131;5648.519875810561;5658.264425624684;5658.462446067617;5669.433056694318;5685.431456854323;5692.402297758737;5739.426057394269;250.21684225851564;5559.138333558305;5652.293463317085;5680.318361796591;5720.141978703207;5546.084895992157;5559;5620.690862002629;5632.549396048306;5651.350094739076;5517.062099443064;5553.389127196006;5600;5616.157576363537;5621.7189140542805;6161.168242287324;6169.907451388232;6180.165677633507;6230.501559875244;6247.625142491465;6694.899576506356;6709.865802683919;6778.389944904982;6792;6804.217514985741;6718.3953444189765;6726.899096513507;6778.525503214728;6798.04827324175;6866.622335771531;6285.2457705075685;6291.748330066792;6296.9370306296805;6303.023031430135;6325.841853953596;6843.863122737517;6876.518643694893;6900.2409734929115;6940.305969403019;6948.131483564554;6537.280899101095;6542.640154791532;6583.44040756541;6612.07430959666;6674.365935236145;6693.866122677519;6701.061851340816;6783.694733736994;6786.626735529593;6814.1482314710665;6684.064231007663;6770.627615481098;6782.186137663413;6784.694688739019;6791.3548212919695;6701.664916754143;6705.631190284581;6713.4964877634375;6806.5916045036465;6808.489363297773;4922.089413458521;4923.359963204761;4933.777979990909;4963.329950456714;4964.950350496449;4492;4529.728216306966;4542.523035081269;4561.087782443525;4561.612262957686;6154.323024467305;6158.107074474176;6170.907436388457;6232.220972378453;6243.157173781572;6665.500087493458;6670.299618540081;6677.666116694146;6713.26154123046;6723.5293529452465;6214.937850621436;6225.28409232935;6259.561830671901;6264.060390941395;6266.968665156645;5415.48552887475;5431.158170483582;5494.066008778437;5503.229547863302;5513.338399392099;6837.931620683829;6927.861442771116;6940.895886561706;7027.578345299298;7028.472864535078;6610.933890661032;6662.96668516664;6672.899906501503;6702.128723265944;6711.060451536887;6847.62338071391;6946.16646002483;7028.156621205488;7039.296070392919;7051.259617740268;6565.671716414065;6628.403443690091;6658.1344425224415;6728.831779205559;6757.054012438361;6745.291744366967;6778.593284402951;6793.456523478011;6805.89791153143;6811.523193376416;6505.837354066186;6544.574602650812;6600.63696496678;6611.07444957716;6618.271990080991;6503.967480162569;6517.3808488193545;6585.604863708193;6612.50406219545;6639.900401494078;6293.716782744696;6322.462590679844;6396.10454536356;6396.6481843497195;6431.517636177212;6594.637294948824;6614.966925165343;6641.568298060611;6660.333966603301;6677.69950352245;6282.183316168869;6346.048092786119;6348.71430785625;6434.8391290218115;6439.452646525097 04:33:28 INFO - PID 20548 | |1;ext.html;931.2317338195988;941.4868896451434;956.4022485946283;996.6212839121133;996.8454889492132;44887.32669009963;46162.07675846481;46206.76896615521;46293;46302;45359.773201134034;46449;46599.30101048487;46866.765666171625;46882.76558617211;8115.797105072391;8212.30195433386;8220.753377398658;8230.588470576477;8232.670693172297;8438.451500652469;8555.828883422328;8559.95720021399;8574.742757717278;8589.398742088057;8620;8647.437916535437;8648.913510864904;8649.048604653482;8651.524166170859;8567.828643427129;8624.827503449897;8626.051134375213;8626.999999999969;8629.61166747498;8437.704680336159;8479.533625650587;8498.915010849874;8513.404061715682;8527.82944341116;41667;41858.37212441816;41888.581114188775;41926.16147677029;42005.78997105025;3796.658300752918;3804.029972357059;3824.521934758155;3825.0437390652337;3841.2893614681375;34723.4791478128;34747.13132171716;35111.29777404463;35143.648563514296;35228.64771352279;5206.401263854667;5344.527795717637;5356.464353564613;5379.623426360156;5453.400125986138;222665;222878;223371;223502;223705;54304.728476358156;54590.18114728282;54873.45126548763;57993;58195.418045819846;61668.383316167165;61857.38142618516;61937.69031154906;61941;62149.37850621526;17503.562410939572;17539.473815785546;17784.377546786058;17856.9107154466;17885;14397.496087636882;14499.565013049625;14505.564833055025;14520.273986300643;14585;16384.26270817816;16410.671786564442;16496.67006659884;16556.75164872528;16642.75035874463;6226.25284965798;6320.873582528324;6383.680815959184;6395.42441180296;6398.776042838478;1095.775366049958;1102.4212288548415;1106.0985296982933;1115.1413411672966;1115.3865374044244;26142;26817;26820.195394138205;26897.596536051973;26969.460610787675;1188.441432526711;1189.2448295332526;1192.0642295797757;1192.2488832035936;1212.6180253220207;13807.450170453092;14069.085509441853;14121.646958825906;14236.644083897778;14271.215083170526;310215;313577;313912;314063;314125;59865;61771.69114154491;65316.346836531025;65347;65367.67316163389;1504.1125735815922;1528.4955964531455;1537.6232822958448;1538.0771537077887;1544.3359355477253;31416.37167256688;31717.841410792797;31866.840665796524;32041.198970025936;32477.350452990337;44049.55950440583;44394.334084989394;44503.10993780171;44517;44522.77738611286;271222;272738;273874;273876;274063;37342.2531549362;38596.22807543889;38797.80601096976;39092.41361379639;39161.41257881191;49879.501204988934;50220.74889625528;50368;50402.495975041245;51095;35626.46560301649;35744.64255357413;35914.46128308025;36204.45693314655;36580;35939;36126.458103127945;36297.27405451823;36788;36812;41984.37023444712;43060.78469607632;43061.56938430575;43077.56922430736;43312.566874330856;34598.30803383968;35110.64889351074;35196.64803352036;35213.47179792254;35216.82391588025;25567.87216063908;26374.868125660018;26601.733982659927;26736.19791406261;26958.191254262405 04:33:28 INFO - PID 20548 | |2;jquery.html;642.0373202515377;642.0639722097541;643.6844576616058;645.2785157611976;647.0286075549234;23701.170459033914;24423.63364549531;24426.75573244267;24465.388365290877;24470.14354497593;26400.20799376017;26569.202923912315;26685.199444016664;26698.466030679374;26720.732792672068;6096.298925623543;6298.055291706258;6539.803805885807;6567.6059436433725;6570.967145164292;6513.869722605545;6609.537332386735;6613.470922326226;6617.768378106767;6620.139381880349;6403.263624683151;6559.180102487189;6563.3108523604815;6575.178102737158;6641.037049627826;6581.2760596334365;6611.471082313427;6612.140421745166;6613.305602911673;6615.569987950767;6139.478144357735;6152.87694246117;6180.289266734293;6197.6901154942525;6199.256089269272;28814.423711525862;30437.391252175054;30835.383292334252;30931;30939.38121237585;2209.657503087008;2256.898439570223;2260.5704916065893;2266.909323627053;2266.9319920402413;20693.68959465609;21334.67997980016;21508.569828603497;21539;21570.676439853414;2577.896884124633;2604.817662763607;2683.315754482614;2686.422419179866;2691.206094202215;126591;132530;163513;168228.15885920613;168712;16577.668446631;17306.394276200273;17308.480745577654;17477.7378339325;17511.912440437973;27001.594976075376;27169.592456113172;27275.454490910466;27286.727132728814;27288;10494.527746251437;10598.470076496144;10626.734331641615;10673.252872298865;10817.593712817441;9513;9516.904830951602;9653.517324133905;9680.806383872283;9695.369800962915;9649.517524123767;9767.023297670175;9951.900480995242;10107.444090574942;10143.594256229668;2913.592097106407;2940.1473572664117;3047.49716296813;3060.9846950765104;3062.555929390226;1042.9739256518496;1043.7599352149048;1045.7124290819934;1054.3779170289565;1056.7199692081604;20949.581008379748;21740;21905.342839714835;22110.447238819157;22233;1089.2484185911696;1100.4662738571785;1112.6773235761539;1113.7494063835572;1114.6043154679971;11662.825057624143;11906.166568340306;12087.214331068453;12140.69648258783;12246.755064898653;624187;625428;630412;643110;662247;134443.32778336047;136897;137467.31266343605;138358.30820846034;139202;1211.8121691137887;1260.5525038611345;1293.1723696834033;1319.81522586836;1331.8401791785047;23222.767772322062;23441.179558715365;23489.765102348756;23540.411489712893;23616;65443.34556654563;65665.67167164134;65925.67037164976;68133;68184;80881;81319;81610;81746;83599;16064;16291.103989280704;16343.59141021484;16418.507444776675;16491.422800201934;22243.332700019026;22309.553808924054;22418.215362462237;22549.323520294416;24930.501389971738;19533.609327813647;19806.70289945623;19993.50016249547;20109;20118.497037573594;17249.655006900044;17638.82361176423;17810.376636817648;18362.540936476697;18386.724199136755;20061.197552098336;20140.79859201448;20370.490737731674;20455.693164602246;20676.793232067488;15950;16145.515634530982;16249.512514624581;16266.105364205083;16324.18379081065;20058;20061.899690501454;20126.29557965464;20171.294004709765;20241 04:33:28 INFO - PID 20548 | |3;mootools.html;1429.3282157386027;1475.1591592792106;1500.549835049485;1509.4188737336126;1517.6964607078587;16782.244798984044;17482.300707971666;17525.29898804048;17527.12364381782;17535.912320438412;17087.48737537873;17145.657086858257;17167.570810729707;17169.055701936388;17229.569260768454;2877.2950627096393;2877.7985541012135;2919.0367178830934;2926.868290926903;2944.749696275808;2870.985645071782;2895.4353900989317;2918.4746745585785;2928.2386579489275;2946.602208701819;2875.683674795771;2966.31774691821;2977.746891514224;2978.910632681023;2979.85100744963;2870.339821840978;2874.2957975295976;2901.7579010850404;2910.694377090417;2912.3738396244908;2858.099698594957;2870.2680816391894;2876.1802886177547;2879.9424011519864;2887.2060183449507;16425;16832.410865619768;16856.662866742598;16871.57821054471;16931.3227470901;8326.292265157468;8601.870971935426;8638;8654.87017694735;8671.349648776304;5480.601671529241;5659.207710920475;5762.279715035621;5780.537556995472;5796.42035796417;2058.372196480073;2196.4508872781803;2562.2057162279752;2694.286014206237;2703.229579569833;31380.21549461259;31808.204794880083;31814.681853181173;31940;31944.361112777846;7746.612669366509;7927.3658107351275;7988.520688758693;8080.797980050545;8123;23589.174378896998;23621.173258935854;23623.88188059049;23651.763482364957;23655.172068977503;8822.691205807765;9003.279737620975;9045.231155351737;9057.81884362309;9058.184763371328;7799.181085986003;8104.311133553596;8113.432059755761;8137.186281371815;8144.14486478923;6283.59156654816;6346.746130154835;6395.392437718409;6409.519286053564;6534.57525260866;1928.758905136858;1989.09496179241;1989.6219718253485;2002.6895831146196;2054.096197673019;946.8674385586023;951.5908159491485;953.4517652349926;959.2901253072675;980.6616717232686;8430.283425908867;8468.576571171418;8510.659573616986;8537.743867683856;8618.224359807647;790.3361176611673;803.1085495100434;816.6284340625001;818.6111596991382;829.2329595124606;5023.246513023076;5517.724113794295;5606.775728970877;5782.335031471351;5846.561507886926;23279.650805237936;25350;25626.359341016625;25660.973561057348;25674.48651026969;23943.161989330638;24710.258692239262;24967.126150585005;25308.746912530638;25343.873280633477;11038.392888391216;11532.769344613062;12574.622761317176;12779.361031948365;13033.47866085384;9176.495292758962;9362.20421264173;9383.01478344764;9397.342186046912;9435.952820235854;21427.357179284645;21537.24619638368;21794.455138621026;21850.562988740454;22475.10099595998;22171;22389.66415503801;22659.546809064057;22762.317130486113;22884.199053033062;13964.930175349058;13970.580882573538;14138.22239776781;14157.009009369245;14206;15307.770383444034;15331.693366132838;15382.769258461356;15401.84598154049;15433.151176685391;12590.811137833123;12772.744545109232;12787.36063196855;12812.61562153137;13007.414666340226;12374.690632734253;12711.80932285998;12777.616671499869;12832.29422381778;12838;10427.21795865298;10489.737756556147;10539.473026348805;10545.103666188154;10613.150947923994;7821.608919553886;7856.410769192219;7860.764177074697;8045.074816395955;8053.436259462016;7954.2117705611545;7963.761087167394;8020.759377218693;8045.477043992122;8065.354771618374 04:33:28 INFO - PID 20548 | |4;prototype.html;551.771015028763;558.8351436326284;582.0977484898408;583.0583607473931;583.1748076471793;6034.8793024139495;6096;6146.139540464339;6146.446819786218;6199.814005579834;5932.139839723238;6013.767177728566;6026.758929642809;6079.8176054718315;6160.537959653022;4829.806807727704;4992.975035124819;5003.774830132653;5023.799048038074;5038.7984480620735;4934.679245849026;4967.453580106186;4979.875503112415;5005.57452616528;5012.248162775594;4886.9511304886855;4944.1594928862;4959.280904268879;4987.8254261100865;5004.974975125119;4889.804407823683;4926.507349265081;4931.50684931504;4940.5800506956775;4977.950220497785;4552.68131230814;4561.885952851172;4569.840055598038;4582.312653102028;4625.583697467244;5968;6079.787207447718;6091.451769340781;6116.296625888035;6166.8766624667705;5792.362840087587;5814.709264536798;5815.505682017034;5850.561207909382;5856.736446859902;6594.208694956588;6600.2409722882;6615.669216539154;6643.269240383603;6646.83382915431;4866.148424025781;5103.413107492649;5113.693178409308;5118.360204974379;5132.538071573539;6620.503462240351;6624.436922861562;6721.764738234138;6736.629485378351;6754.527183097185;5148.845534633967;5166.121759300928;5199.428062913076;5201.089809283436;5210.296609957683;5231.450697676765;5242.895142097137;5249.527542521191;5284.445133261029;5318;5743.62666426681;5823.475887170175;5825.475707186289;5829.88340233193;5839.678817664984;6540.59377233897;6575.934240657628;6615.270081891471;6645.933540664628;6659.602543084486;1813.2565648084221;1813.673538763009;1818.1545581304492;1828.1590468384693;1833.6332733453362;1247.6257122863105;1302.1470936536584;1313.6847156682327;1328.448693792085;1333.5732565579115;5946.167536544887;6005.939940600625;6012.939870601325;6017.578769486094;6107.328193898667;6488;6501.772437964649;6539.411452969161;6551.836204094936;6568.573042752301;5977.970110149421;5985.610935289193;5987.9101813472835;6021.397860213943;6062.605930614496;3435.1927297085167;3455.3607582596796;3463.7402194834985;3473;3493.6681015303507;6797.6601169941305;6829.565791183808;6878.211664967044;6885.311468853175;6910.099722576231;6757.189137303555;6803.081583986197;6822.4200942919415;6835.624040677811;6838.213605435439;6676.265610782712;6807.21717002551;6859;6898.241193468714;6949.270326615733;6491.156149700509;6527.3472652734345;6549.96725016391;6554.901676474952;6589.7364105435245;6591;6603.7688680895935;6612.801615951529;6616.603003819786;6651.068850360856;6851.177858656793;6851.9657401712675;6881;6934.757283495053;6935.89596156048;5190.117679994334;5202.8959420812125;5209.791608335624;5225.764840582106;5228.921566176587;6424.325445828121;6529.542931994714;6623.900641490478;6664.233613134552;6667.66661666905;5991.400859913973;6442.194725659293;6457.418832305115;6458.160439142881;6481.384268494486;6311.084892690626;6347.96826015867;6442.742290308523;6454.386833250834;6521.510886683613;6199.969000154971;6258.155149054819;6292.622442653455;6302.401271879165;6320.810375688737;6434.485241180788;6452.290248072614;6460;6469.350315669474;6480.99089282324;6290.056491526308;6294.527910406646;6351.460125889351;6351.587146835441;6380.553361264667 04:33:28 INFO - PID 20548 | |5;yui.html;972.8297547929113;989.4656885281948;994.960266521485;995.2137811129209;997.9251556133289;20318;21040.053197606125;21048.89475552622;21068.367948961557;21308.254211102616;19145.712814307797;19352.322668706598;19367.806321936776;19462;19472.513187170327;1067.0769784136724;1080.61638118468;1081.2701426537096;1081.967540973768;1082.7509672775266;1065.8188108021654;1112.8386383974319;1116.681745702475;1117.0560876059717;1117.8770335263155;1148.62095508482;1152.268309623391;1152.3489228585863;1152.9942350288236;1153.9826902596467;1139.680889350983;1150.0512077535982;1151.9769604607945;1154.7113221694535;1157.3171828621112;847.6270441006;849.290842146802;850.4684572142411;850.5874650794422;851.1786126388065;20170.19319227229;20199;21055.5788884223;21374.679379809317;21558.461038474008;22812.08751649932;23162;23516.412089697893;23624.527509449716;23643.172488962802;17789.73315400257;17853.7321940171;18082.186301616326;18109.637807243915;18134.90932545342;3927.0575061985205;3999.1801680655394;4003.019260281221;4003.799810009517;4004.619561141687;164841.17579412146;167074.99999999878;168291;169557;170668.14665926716;15531.45639902598;15794.763078553831;15872.841271587367;15899;15958.521244362688;32754.672453275638;33565.664343356744;33873.491897621556;33949.83025084859;34093.318133637185;9063.32025098107;9153.313501487415;9191.264698824078;9300;9453.196478299284;4710.69380490267;4786.042791441726;4789.3294938708605;4797.280407938767;4800.567948884617;6098.847528811726;6129.356417576179;6157;6186.876262474725;6193.907091393633;1032.6798692405378;1042.994785026085;1049.816282150636;1050.648032908984;1056.730533713898;686.2348481443255;699.8810202265627;709.1065257775138;714.9034880291198;724.5181954000636;12545.247285162919;12556.30940298274;12975.94090046924;13034.80447793284;13093.345332733325;694.1704662927752;695.9199692035379;697.6546609428264;702.8945658151318;709.9918116274902;6063.818085457443;6070.969645151746;6080.452759251689;6107.908381374283;6163.476104531075;157760;158503;159446;160215.19892400462;160712;137642;138502;142902.28548857188;144158;145267;118133;121546.3922680381;121919;122026.38986805186;123458;11445.198836081394;11467.31196128235;11495.712607184887;11705;11887.405629718653;60079;60613.69693151506;61117.08324375049;61150.69424652848;61586;75857;75910.62044689742;76743.2325676736;77460;79596;16273.104979226257;16467.67064658676;16481.752773708642;16723.749143763096;16762.832371676126;19069.618607627493;19131.426057218305;19180.616387672446;19374;19540.902295489;15373.846261537241;15804.130772807606;15876.285567149736;15912.681746364777;15969.44106956251;17095.7435638468;17202;17209.139543023048;17287.827121729126;17358.132093395026;15999.960002599793;16027.919860400623;16102.43641472543;16238.188090595188;16253.349866005228;12449.813252801396;12511.786863571877;12659.556915507914;12832.679183020125;12834;12117;12132.575359862716;12230.87769122333;12741.17182383142;12755.298458584866 04:33:28 INFO - PID 20548 | __end_tp_report 04:33:28 INFO - PID 20548 | __start_cc_report 04:33:28 INFO - PID 20548 | _x_x_mozilla_cycle_collect,260 04:33:28 INFO - PID 20548 | __end_cc_report 04:33:28 INFO - PID 20548 | __startTimestamp1506684808307__endTimestamp 04:33:28 INFO - PID 20548 | 04:33:28 INFO - PID 20548 | ------- Summary: start ------- 04:33:28 INFO - PID 20548 | Number of tests: 6 04:33:28 INFO - PID 20548 | 04:33:28 INFO - PID 20548 | [#0] dojo.html Cycles:165 Average:6178.21 Median:6431.52 stddev:851.99 (13.2%) stddev-sans-first:835.57 04:33:28 INFO - PID 20548 | Values: 3895.6 3903.0 3913.5 3920.0 3922.5 6017.9 6172.5 6239.3 6270.3 6328.6 6217.2 6251.9 6270.3 6272.2 6282.1 5526.8 5597.6 5603.5 5648.5 5658.3 5658.5 5669.4 5685.4 5692.4 5739.4 250.2 5559.1 5652.3 5680.3 5720.1 5546.1 5559.0 5620.7 5632.5 5651.4 5517.1 5553.4 5600.0 5616.2 5621.7 6161.2 6169.9 6180.2 6230.5 6247.6 6694.9 6709.9 6778.4 6792.0 6804.2 6718.4 6726.9 6778.5 6798.0 6866.6 6285.2 6291.7 6296.9 6303.0 6325.8 6843.9 6876.5 6900.2 6940.3 6948.1 6537.3 6542.6 6583.4 6612.1 6674.4 6693.9 6701.1 6783.7 6786.6 6814.1 6684.1 6770.6 6782.2 6784.7 6791.4 6701.7 6705.6 6713.5 6806.6 6808.5 4922.1 4923.4 4933.8 4963.3 4965.0 4492.0 4529.7 4542.5 4561.1 4561.6 6154.3 6158.1 6170.9 6232.2 6243.2 6665.5 6670.3 6677.7 6713.3 6723.5 6214.9 6225.3 6259.6 6264.1 6267.0 5415.5 5431.2 5494.1 5503.2 5513.3 6837.9 6927.9 6940.9 7027.6 7028.5 6610.9 6663.0 6672.9 6702.1 6711.1 6847.6 6946.2 7028.2 7039.3 7051.3 6565.7 6628.4 6658.1 6728.8 6757.1 6745.3 6778.6 6793.5 6805.9 6811.5 6505.8 6544.6 6600.6 6611.1 6618.3 6504.0 6517.4 6585.6 6612.5 6639.9 6293.7 6322.5 6396.1 6396.6 6431.5 6594.6 6615.0 6641.6 6660.3 6677.7 6282.2 6346.0 6348.7 6434.8 6439.5 04:33:28 INFO - PID 20548 | 04:33:28 INFO - PID 20548 | [#1] ext.html Cycles:180 Average:45964.35 Median:21218.76 stddev:70966.96 (334.5%) stddev-sans-first:71085.49 04:33:28 INFO - PID 20548 | Values: 931.2 941.5 956.4 996.6 996.8 44887.3 46162.1 46206.8 46293.0 46302.0 45359.8 46449.0 46599.3 46866.8 46882.8 8115.8 8212.3 8220.8 8230.6 8232.7 8438.5 8555.8 8560.0 8574.7 8589.4 8620.0 8647.4 8648.9 8649.0 8651.5 8567.8 8624.8 8626.1 8627.0 8629.6 8437.7 8479.5 8498.9 8513.4 8527.8 41667.0 41858.4 41888.6 41926.2 42005.8 3796.7 3804.0 3824.5 3825.0 3841.3 34723.5 34747.1 35111.3 35143.6 35228.6 5206.4 5344.5 5356.5 5379.6 5453.4 222665.0 222878.0 223371.0 223502.0 223705.0 54304.7 54590.2 54873.5 57993.0 58195.4 61668.4 61857.4 61937.7 61941.0 62149.4 17503.6 17539.5 17784.4 17856.9 17885.0 14397.5 14499.6 14505.6 14520.3 14585.0 16384.3 16410.7 16496.7 16556.8 16642.8 6226.3 6320.9 6383.7 6395.4 6398.8 1095.8 1102.4 1106.1 1115.1 1115.4 26142.0 26817.0 26820.2 26897.6 26969.5 1188.4 1189.2 1192.1 1192.2 1212.6 13807.5 14069.1 14121.6 14236.6 14271.2 310215.0 313577.0 313912.0 314063.0 314125.0 59865.0 61771.7 65316.3 65347.0 65367.7 1504.1 1528.5 1537.6 1538.1 1544.3 31416.4 31717.8 31866.8 32041.2 32477.4 44049.6 44394.3 44503.1 44517.0 44522.8 271222.0 272738.0 273874.0 273876.0 274063.0 37342.3 38596.2 38797.8 39092.4 39161.4 49879.5 50220.7 50368.0 50402.5 51095.0 35626.5 35744.6 35914.5 36204.5 36580.0 35939.0 36126.5 36297.3 36788.0 36812.0 41984.4 43060.8 43061.6 43077.6 43312.6 34598.3 35110.6 35196.6 35213.5 35216.8 25567.9 26374.9 26601.7 26736.2 26958.2 04:33:28 INFO - PID 20548 | 04:33:28 INFO - PID 20548 | [#2] jquery.html Cycles:180 Average:41313.25 Median:12744.85 stddev:106499.36 (835.6%) stddev-sans-first:106754.34 04:33:28 INFO - PID 20548 | Values: 642.0 642.1 643.7 645.3 647.0 23701.2 24423.6 24426.8 24465.4 24470.1 26400.2 26569.2 26685.2 26698.5 26720.7 6096.3 6298.1 6539.8 6567.6 6571.0 6513.9 6609.5 6613.5 6617.8 6620.1 6403.3 6559.2 6563.3 6575.2 6641.0 6581.3 6611.5 6612.1 6613.3 6615.6 6139.5 6152.9 6180.3 6197.7 6199.3 28814.4 30437.4 30835.4 30931.0 30939.4 2209.7 2256.9 2260.6 2266.9 2266.9 20693.7 21334.7 21508.6 21539.0 21570.7 2577.9 2604.8 2683.3 2686.4 2691.2 126591.0 132530.0 163513.0 168228.2 168712.0 16577.7 17306.4 17308.5 17477.7 17511.9 27001.6 27169.6 27275.5 27286.7 27288.0 10494.5 10598.5 10626.7 10673.3 10817.6 9513.0 9516.9 9653.5 9680.8 9695.4 9649.5 9767.0 9951.9 10107.4 10143.6 2913.6 2940.1 3047.5 3061.0 3062.6 1043.0 1043.8 1045.7 1054.4 1056.7 20949.6 21740.0 21905.3 22110.4 22233.0 1089.2 1100.5 1112.7 1113.7 1114.6 11662.8 11906.2 12087.2 12140.7 12246.8 624187.0 625428.0 630412.0 643110.0 662247.0 134443.3 136897.0 137467.3 138358.3 139202.0 1211.8 1260.6 1293.2 1319.8 1331.8 23222.8 23441.2 23489.8 23540.4 23616.0 65443.3 65665.7 65925.7 68133.0 68184.0 80881.0 81319.0 81610.0 81746.0 83599.0 16064.0 16291.1 16343.6 16418.5 16491.4 22243.3 22309.6 22418.2 22549.3 24930.5 19533.6 19806.7 19993.5 20109.0 20118.5 17249.7 17638.8 17810.4 18362.5 18386.7 20061.2 20140.8 20370.5 20455.7 20676.8 15950.0 16145.5 16249.5 16266.1 16324.2 20058.0 20061.9 20126.3 20171.3 20241.0 04:33:28 INFO - PID 20548 | 04:33:28 INFO - PID 20548 | [#3] mootools.html Cycles:180 Average:10723.61 Median:2875.93 stddev:8001.82 (278.2%) stddev-sans-first:7993.80 04:33:28 INFO - PID 20548 | Values: 1429.3 1475.2 1500.5 1509.4 1517.7 16782.2 17482.3 17525.3 17527.1 17535.9 17087.5 17145.7 17167.6 17169.1 17229.6 2877.3 2877.8 2919.0 2926.9 2944.7 2871.0 2895.4 2918.5 2928.2 2946.6 2875.7 2966.3 2977.7 2978.9 2979.9 2870.3 2874.3 2901.8 2910.7 2912.4 2858.1 2870.3 2876.2 2879.9 2887.2 16425.0 16832.4 16856.7 16871.6 16931.3 8326.3 8601.9 8638.0 8654.9 8671.3 5480.6 5659.2 5762.3 5780.5 5796.4 2058.4 2196.5 2562.2 2694.3 2703.2 31380.2 31808.2 31814.7 31940.0 31944.4 7746.6 7927.4 7988.5 8080.8 8123.0 23589.2 23621.2 23623.9 23651.8 23655.2 8822.7 9003.3 9045.2 9057.8 9058.2 7799.2 8104.3 8113.4 8137.2 8144.1 6283.6 6346.7 6395.4 6409.5 6534.6 1928.8 1989.1 1989.6 2002.7 2054.1 946.9 951.6 953.5 959.3 980.7 8430.3 8468.6 8510.7 8537.7 8618.2 790.3 803.1 816.6 818.6 829.2 5023.2 5517.7 5606.8 5782.3 5846.6 23279.7 25350.0 25626.4 25661.0 25674.5 23943.2 24710.3 24967.1 25308.7 25343.9 11038.4 11532.8 12574.6 12779.4 13033.5 9176.5 9362.2 9383.0 9397.3 9436.0 21427.4 21537.2 21794.5 21850.6 22475.1 22171.0 22389.7 22659.5 22762.3 22884.2 13964.9 13970.6 14138.2 14157.0 14206.0 15307.8 15331.7 15382.8 15401.8 15433.2 12590.8 12772.7 12787.4 12812.6 13007.4 12374.7 12711.8 12777.6 12832.3 12838.0 10427.2 10489.7 10539.5 10545.1 10613.2 7821.6 7856.4 7860.8 8045.1 8053.4 7954.2 7963.8 8020.8 8045.5 8065.4 04:33:28 INFO - PID 20548 | 04:33:28 INFO - PID 20548 | [#4] prototype.html Cycles:180 Average:5546.42 Median:6079.80 stddev:1525.85 (25.1%) stddev-sans-first:1483.36 04:33:28 INFO - PID 20548 | Values: 551.8 558.8 582.1 583.1 583.2 6034.9 6096.0 6146.1 6146.4 6199.8 5932.1 6013.8 6026.8 6079.8 6160.5 4829.8 4993.0 5003.8 5023.8 5038.8 4934.7 4967.5 4979.9 5005.6 5012.2 4887.0 4944.2 4959.3 4987.8 5005.0 4889.8 4926.5 4931.5 4940.6 4978.0 4552.7 4561.9 4569.8 4582.3 4625.6 5968.0 6079.8 6091.5 6116.3 6166.9 5792.4 5814.7 5815.5 5850.6 5856.7 6594.2 6600.2 6615.7 6643.3 6646.8 4866.1 5103.4 5113.7 5118.4 5132.5 6620.5 6624.4 6721.8 6736.6 6754.5 5148.8 5166.1 5199.4 5201.1 5210.3 5231.5 5242.9 5249.5 5284.4 5318.0 5743.6 5823.5 5825.5 5829.9 5839.7 6540.6 6575.9 6615.3 6645.9 6659.6 1813.3 1813.7 1818.2 1828.2 1833.6 1247.6 1302.1 1313.7 1328.4 1333.6 5946.2 6005.9 6012.9 6017.6 6107.3 6488.0 6501.8 6539.4 6551.8 6568.6 5978.0 5985.6 5987.9 6021.4 6062.6 3435.2 3455.4 3463.7 3473.0 3493.7 6797.7 6829.6 6878.2 6885.3 6910.1 6757.2 6803.1 6822.4 6835.6 6838.2 6676.3 6807.2 6859.0 6898.2 6949.3 6491.2 6527.3 6550.0 6554.9 6589.7 6591.0 6603.8 6612.8 6616.6 6651.1 6851.2 6852.0 6881.0 6934.8 6935.9 5190.1 5202.9 5209.8 5225.8 5228.9 6424.3 6529.5 6623.9 6664.2 6667.7 5991.4 6442.2 6457.4 6458.2 6481.4 6311.1 6348.0 6442.7 6454.4 6521.5 6200.0 6258.2 6292.6 6302.4 6320.8 6434.5 6452.3 6460.0 6469.4 6481.0 6290.1 6294.5 6351.5 6351.6 6380.6 04:33:28 INFO - PID 20548 | 04:33:28 INFO - PID 20548 | [#5] yui.html Cycles:180 Average:29277.94 Median:17821.73 stddev:45171.47 (253.5%) stddev-sans-first:45248.19 04:33:28 INFO - PID 20548 | Values: 972.8 989.5 995.0 995.2 997.9 20318.0 21040.1 21048.9 21068.4 21308.3 19145.7 19352.3 19367.8 19462.0 19472.5 1067.1 1080.6 1081.3 1082.0 1082.8 1065.8 1112.8 1116.7 1117.1 1117.9 1148.6 1152.3 1152.3 1153.0 1154.0 1139.7 1150.1 1152.0 1154.7 1157.3 847.6 849.3 850.5 850.6 851.2 20170.2 20199.0 21055.6 21374.7 21558.5 22812.1 23162.0 23516.4 23624.5 23643.2 17789.7 17853.7 18082.2 18109.6 18134.9 3927.1 3999.2 4003.0 4003.8 4004.6 164841.2 167075.0 168291.0 169557.0 170668.1 15531.5 15794.8 15872.8 15899.0 15958.5 32754.7 33565.7 33873.5 33949.8 34093.3 9063.3 9153.3 9191.3 9300.0 9453.2 4710.7 4786.0 4789.3 4797.3 4800.6 6098.8 6129.4 6157.0 6186.9 6193.9 1032.7 1043.0 1049.8 1050.6 1056.7 686.2 699.9 709.1 714.9 724.5 12545.2 12556.3 12975.9 13034.8 13093.3 694.2 695.9 697.7 702.9 710.0 6063.8 6071.0 6080.5 6107.9 6163.5 157760.0 158503.0 159446.0 160215.2 160712.0 137642.0 138502.0 142902.3 144158.0 145267.0 118133.0 121546.4 121919.0 122026.4 123458.0 11445.2 11467.3 11495.7 11705.0 11887.4 60079.0 60613.7 61117.1 61150.7 61586.0 75857.0 75910.6 76743.2 77460.0 79596.0 16273.1 16467.7 16481.8 16723.7 16762.8 19069.6 19131.4 19180.6 19374.0 19540.9 15373.8 15804.1 15876.3 15912.7 15969.4 17095.7 17202.0 17209.1 17287.8 17358.1 16000.0 16027.9 16102.4 16238.2 16253.3 12449.8 12511.8 12659.6 12832.7 12834.0 12117.0 12132.6 12230.9 12741.2 12755.3 04:33:28 INFO - PID 20548 | -------- Summary: end -------- 04:33:28 INFO - PID 20548 | 04:33:28 INFO - TEST-INFO | 20548: exit 0 04:33:28 INFO - TEST-OK | dromaeo_css | took 1106142ms 04:33:28 INFO - TEST-START | kraken 04:33:28 INFO - Initialising browser for kraken test... 04:33:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36759/getInfo.html -profile /tmp/tmpF3PQYS/profile 04:33:28 INFO - TEST-INFO | started process 20915 (/builds/slave/test/build/application/firefox/firefox http://localhost:36759/getInfo.html) 04:33:33 INFO - TEST-INFO | 20915: exit 0 04:33:33 INFO - Browser initialized. 04:33:33 INFO - Running cycle 1/1 for kraken test... 04:33:33 INFO - Using env: {'DISPLAY': ':0', 04:33:33 INFO - 'HOME': '/home/cltbld', 04:33:33 INFO - 'JSGC_DISABLE_POISONING': '1', 04:33:33 INFO - 'LANG': 'en_US.UTF-8', 04:33:33 INFO - 'LANGUAGE': 'en_US:en', 04:33:33 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:33:33 INFO - 'LOGNAME': 'cltbld', 04:33:33 INFO - 'MAIL': '/var/mail/cltbld', 04:33:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:33:33 INFO - 'MOZ_CRASHREPORTER': '1', 04:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:33 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:33:33 INFO - 'MOZ_NO_REMOTE': '1', 04:33:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:33 INFO - 'NO_EM_RESTART': '1', 04:33:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:33 INFO - 'PWD': '/builds/slave/test', 04:33:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:33 INFO - 'RUST_BACKTRACE': 'full', 04:33:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:33:33 INFO - 'SHELL': '/bin/bash', 04:33:33 INFO - 'SHLVL': '1', 04:33:33 INFO - 'TERM': 'linux', 04:33:33 INFO - 'TMOUT': '86400', 04:33:33 INFO - 'USER': 'cltbld', 04:33:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375', 04:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:33 INFO - '_': '/tools/buildbot/bin/python'} 04:33:33 INFO - TEST-INFO | started process 21153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF3PQYS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:34 INFO - PID 21153 | 04:33:34 INFO - PID 21153 | (/builds/slave/test/build/application/firefox/firefox:21202): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:33:34 INFO - PID 21153 | 04:33:44 INFO - PID 21153 | RSS: Main: 145342464 04:33:44 INFO - PID 21153 | 04:33:47 INFO - PID 21153 | Cycle 1(1): loaded http://localhost:36759/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36759/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:48 INFO - PID 21153 | RSS: Main: 150990848 04:33:48 INFO - PID 21153 | 04:33:50 INFO - PID 21153 | Cycle 1(1): loaded http://localhost:36759/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36759/tests/kraken/driver.html?testName=audio-dft) 04:33:51 INFO - PID 21153 | RSS: Main: 151252992 04:33:51 INFO - PID 21153 | 04:33:54 INFO - PID 21153 | Cycle 1(1): loaded http://localhost:36759/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36759/tests/kraken/driver.html?testName=audio-fft) 04:33:55 INFO - PID 21153 | RSS: Main: 147656704 04:33:55 INFO - PID 21153 | 04:33:57 INFO - PID 21153 | Cycle 1(1): loaded http://localhost:36759/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36759/tests/kraken/driver.html?testName=audio-oscillator) 04:33:57 INFO - PID 21153 | RSS: Main: 149028864 04:33:57 INFO - PID 21153 | 04:33:59 INFO - PID 21153 | Cycle 1(1): loaded http://localhost:36759/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36759/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:34:00 INFO - PID 21153 | RSS: Main: 148553728 04:34:00 INFO - PID 21153 | 04:34:03 INFO - PID 21153 | Cycle 1(1): loaded http://localhost:36759/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36759/tests/kraken/driver.html?testName=imaging-darkroom) 04:34:04 INFO - PID 21153 | RSS: Main: 148836352 04:34:04 INFO - PID 21153 | 04:34:07 INFO - PID 21153 | Cycle 1(1): loaded http://localhost:36759/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36759/tests/kraken/driver.html?testName=imaging-desaturate) 04:34:08 INFO - PID 21153 | RSS: Main: 150323200 04:34:08 INFO - PID 21153 | 04:34:11 INFO - PID 21153 | Cycle 1(1): loaded http://localhost:36759/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36759/tests/kraken/driver.html?testName=json-parse-financial) 04:34:11 INFO - PID 21153 | RSS: Main: 151339008 04:34:11 INFO - PID 21153 | 04:34:13 INFO - PID 21153 | Cycle 1(1): loaded http://localhost:36759/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36759/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:34:13 INFO - PID 21153 | RSS: Main: 151318528 04:34:13 INFO - PID 21153 | 04:34:15 INFO - PID 21153 | Cycle 1(1): loaded http://localhost:36759/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36759/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:34:16 INFO - PID 21153 | RSS: Main: 151388160 04:34:16 INFO - PID 21153 | 04:34:18 INFO - PID 21153 | Cycle 1(1): loaded http://localhost:36759/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36759/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:18 INFO - PID 21153 | RSS: Main: 148107264 04:34:18 INFO - PID 21153 | 04:34:21 INFO - PID 21153 | Cycle 1(1): loaded http://localhost:36759/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36759/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:21 INFO - PID 21153 | RSS: Main: 147968000 04:34:21 INFO - PID 21153 | 04:34:24 INFO - PID 21153 | Cycle 1(1): loaded http://localhost:36759/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36759/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:25 INFO - PID 21153 | RSS: Main: 148475904 04:34:25 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | Cycle 1(1): loaded http://localhost:36759/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36759/tests/kraken/driver.html?testName=ai-astar) 04:34:26 INFO - PID 21153 | RSS: Main: 150048768 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | __start_tp_report 04:34:26 INFO - PID 21153 | _x_x_mozilla_page_load 04:34:26 INFO - PID 21153 | _x_x_mozilla_page_load_details 04:34:26 INFO - PID 21153 | |i|pagename|runs| 04:34:26 INFO - PID 21153 | |0;ai-astar;105;106;104;105;105;109;107;107;107;108 04:34:26 INFO - PID 21153 | |1;audio-beat-detection;117;114;111;111;116;115;115;113;113;112 04:34:26 INFO - PID 21153 | |2;audio-dft;162;163;161;161;162;160;161;162;164;162 04:34:26 INFO - PID 21153 | |3;audio-fft;88;74;74;73;74;74;72;74;75;73 04:34:26 INFO - PID 21153 | |4;audio-oscillator;78;79;83;78;77;77;78;78;79;78 04:34:26 INFO - PID 21153 | |5;imaging-gaussian-blur;111;112;121;112;116;112;117;113;111;117 04:34:26 INFO - PID 21153 | |6;imaging-darkroom;150;151;152;150;150;150;152;149;150;151 04:34:26 INFO - PID 21153 | |7;imaging-desaturate;94;94;93;94;94;94;94;95;94;96 04:34:26 INFO - PID 21153 | |8;json-parse-financial;43;44;45;46;46;44;44;44;43;48 04:34:26 INFO - PID 21153 | |9;json-stringify-tinderbox;40;39;39;38;38;38;38;38;38;38 04:34:26 INFO - PID 21153 | |10;stanford-crypto-aes;72;71;76;73;74;72;71;72;70;74 04:34:26 INFO - PID 21153 | |11;stanford-crypto-ccm;107;105;105;106;108;109;102;104;109;116 04:34:26 INFO - PID 21153 | |12;stanford-crypto-pbkdf2;148;154;151;153;156;157;157;150;156;149 04:34:26 INFO - PID 21153 | |13;stanford-crypto-sha256-iterative;64;70;62;60;58;62;58;60;57;59 04:34:26 INFO - PID 21153 | __end_tp_report 04:34:26 INFO - PID 21153 | __start_cc_report 04:34:26 INFO - PID 21153 | _x_x_mozilla_cycle_collect,715 04:34:26 INFO - PID 21153 | __end_cc_report 04:34:26 INFO - PID 21153 | __startTimestamp1506684866965__endTimestamp 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | ------- Summary: start ------- 04:34:26 INFO - PID 21153 | Number of tests: 14 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | [#0] ai-astar Cycles:10 Average:106.30 Median:107.00 stddev:1.57 (1.5%) stddev-sans-first:1.59 04:34:26 INFO - PID 21153 | Values: 105.0 106.0 104.0 105.0 105.0 109.0 107.0 107.0 107.0 108.0 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | [#1] audio-beat-detection Cycles:10 Average:113.70 Median:114.50 stddev:2.06 (1.8%) stddev-sans-first:1.80 04:34:26 INFO - PID 21153 | Values: 117.0 114.0 111.0 111.0 116.0 115.0 115.0 113.0 113.0 112.0 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 04:34:26 INFO - PID 21153 | Values: 162.0 163.0 161.0 161.0 162.0 160.0 161.0 162.0 164.0 162.0 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | [#3] audio-fft Cycles:10 Average:75.10 Median:74.00 stddev:4.61 (6.2%) stddev-sans-first:0.87 04:34:26 INFO - PID 21153 | Values: 88.0 74.0 74.0 73.0 74.0 74.0 72.0 74.0 75.0 73.0 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | [#4] audio-oscillator Cycles:10 Average:78.50 Median:78.00 stddev:1.72 (2.2%) stddev-sans-first:1.81 04:34:26 INFO - PID 21153 | Values: 78.0 79.0 83.0 78.0 77.0 77.0 78.0 78.0 79.0 78.0 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.50 stddev:3.36 (2.9%) stddev-sans-first:3.36 04:34:26 INFO - PID 21153 | Values: 111.0 112.0 121.0 112.0 116.0 112.0 117.0 113.0 111.0 117.0 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 04:34:26 INFO - PID 21153 | Values: 150.0 151.0 152.0 150.0 150.0 150.0 152.0 149.0 150.0 151.0 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 04:34:26 INFO - PID 21153 | Values: 94.0 94.0 93.0 94.0 94.0 94.0 94.0 95.0 94.0 96.0 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | [#8] json-parse-financial Cycles:10 Average:44.70 Median:44.50 stddev:1.57 (3.5%) stddev-sans-first:1.54 04:34:26 INFO - PID 21153 | Values: 43.0 44.0 45.0 46.0 46.0 44.0 44.0 44.0 43.0 48.0 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | [#9] json-stringify-tinderbox Cycles:10 Average:38.40 Median:38.00 stddev:0.70 (1.8%) stddev-sans-first:0.44 04:34:26 INFO - PID 21153 | Values: 40.0 39.0 39.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | [#10] stanford-crypto-aes Cycles:10 Average:72.50 Median:72.50 stddev:1.78 (2.5%) stddev-sans-first:1.88 04:34:26 INFO - PID 21153 | Values: 72.0 71.0 76.0 73.0 74.0 72.0 71.0 72.0 70.0 74.0 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | [#11] stanford-crypto-ccm Cycles:10 Average:107.10 Median:107.50 stddev:3.84 (3.6%) stddev-sans-first:4.08 04:34:26 INFO - PID 21153 | Values: 107.0 105.0 105.0 106.0 108.0 109.0 102.0 104.0 109.0 116.0 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:155.00 stddev:3.41 (2.2%) stddev-sans-first:3.08 04:34:26 INFO - PID 21153 | Values: 148.0 154.0 151.0 153.0 156.0 157.0 157.0 150.0 156.0 149.0 04:34:26 INFO - PID 21153 | 04:34:26 INFO - PID 21153 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.00 Median:61.00 stddev:3.83 (6.3%) stddev-sans-first:3.91 04:34:26 INFO - PID 21153 | Values: 64.0 70.0 62.0 60.0 58.0 62.0 58.0 60.0 57.0 59.0 04:34:26 INFO - PID 21153 | -------- Summary: end -------- 04:34:26 INFO - PID 21153 | 04:34:27 INFO - PID 21153 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:34:27 INFO - TEST-INFO | 21153: exit 0 04:34:27 INFO - TEST-OK | kraken | took 58783ms 04:34:27 INFO - SUITE-END | took 1164s 04:34:27 INFO - Completed test suite (00:19:24) 04:34:27 INFO - javascript benchmark 04:34:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9167.441977772805, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3895.5909629488906, 3902.9804850975743, 3913.452116703662, 3920.039590300377, 3922.490076290082, 6017.939820601792, 6172.5370597205165, 6239.313675495698, 6270.27891792444, 6328.557001009931, 6217.160683307752, 6251.906221406683, 6270.27891792444, 6272.153259309992, 6282.0576913463, 5526.778928842841, 5597.552195824324, 5603.46767057131, 5648.519875810561, 5658.264425624684, 5658.462446067617, 5669.433056694318, 5685.431456854323, 5692.402297758737, 5739.426057394269, 250.21684225851564, 5559.138333558305, 5652.293463317085, 5680.318361796591, 5720.141978703207, 5546.084895992157, 5559.0, 5620.690862002629, 5632.549396048306, 5651.350094739076, 5517.062099443064, 5553.389127196006, 5600.0, 5616.157576363537, 5621.7189140542805, 6161.168242287324, 6169.907451388232, 6180.165677633507, 6230.501559875244, 6247.625142491465, 6694.899576506356, 6709.865802683919, 6778.389944904982, 6792.0, 6804.217514985741, 6718.3953444189765, 6726.899096513507, 6778.525503214728, 6798.04827324175, 6866.622335771531, 6285.2457705075685, 6291.748330066792, 6296.9370306296805, 6303.023031430135, 6325.841853953596, 6843.863122737517, 6876.518643694893, 6900.2409734929115, 6940.305969403019, 6948.131483564554, 6537.280899101095, 6542.640154791532, 6583.44040756541, 6612.07430959666, 6674.365935236145, 6693.866122677519, 6701.061851340816, 6783.694733736994, 6786.626735529593, 6814.1482314710665, 6684.064231007663, 6770.627615481098, 6782.186137663413, 6784.694688739019, 6791.3548212919695, 6701.664916754143, 6705.631190284581, 6713.4964877634375, 6806.5916045036465, 6808.489363297773, 4922.089413458521, 4923.359963204761, 4933.777979990909, 4963.329950456714, 4964.950350496449, 4492.0, 4529.728216306966, 4542.523035081269, 4561.087782443525, 4561.612262957686, 6154.323024467305, 6158.107074474176, 6170.907436388457, 6232.220972378453, 6243.157173781572, 6665.500087493458, 6670.299618540081, 6677.666116694146, 6713.26154123046, 6723.5293529452465, 6214.937850621436, 6225.28409232935, 6259.561830671901, 6264.060390941395, 6266.968665156645, 5415.48552887475, 5431.158170483582, 5494.066008778437, 5503.229547863302, 5513.338399392099, 6837.931620683829, 6927.861442771116, 6940.895886561706, 7027.578345299298, 7028.472864535078, 6610.933890661032, 6662.96668516664, 6672.899906501503, 6702.128723265944, 6711.060451536887, 6847.62338071391, 6946.16646002483, 7028.156621205488, 7039.296070392919, 7051.259617740268, 6565.671716414065, 6628.403443690091, 6658.1344425224415, 6728.831779205559, 6757.054012438361, 6745.291744366967, 6778.593284402951, 6793.456523478011, 6805.89791153143, 6811.523193376416, 6505.837354066186, 6544.574602650812, 6600.63696496678, 6611.07444957716, 6618.271990080991, 6503.967480162569, 6517.3808488193545, 6585.604863708193, 6612.50406219545, 6639.900401494078, 6293.716782744696, 6322.462590679844, 6396.10454536356, 6396.6481843497195, 6431.517636177212, 6594.637294948824, 6614.966925165343, 6641.568298060611, 6660.333966603301, 6677.69950352245, 6282.183316168869, 6346.048092786119, 6348.71430785625, 6434.8391290218115, 6439.452646525097], "value": 6124.472394879732, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [931.2317338195988, 941.4868896451434, 956.4022485946283, 996.6212839121133, 996.8454889492132, 44887.32669009963, 46162.07675846481, 46206.76896615521, 46293.0, 46302.0, 45359.773201134034, 46449.0, 46599.30101048487, 46866.765666171625, 46882.76558617211, 8115.797105072391, 8212.30195433386, 8220.753377398658, 8230.588470576477, 8232.670693172297, 8438.451500652469, 8555.828883422328, 8559.95720021399, 8574.742757717278, 8589.398742088057, 8620.0, 8647.437916535437, 8648.913510864904, 8649.048604653482, 8651.524166170859, 8567.828643427129, 8624.827503449897, 8626.051134375213, 8626.999999999969, 8629.61166747498, 8437.704680336159, 8479.533625650587, 8498.915010849874, 8513.404061715682, 8527.82944341116, 41667.0, 41858.37212441816, 41888.581114188775, 41926.16147677029, 42005.78997105025, 3796.658300752918, 3804.029972357059, 3824.521934758155, 3825.0437390652337, 3841.2893614681375, 34723.4791478128, 34747.13132171716, 35111.29777404463, 35143.648563514296, 35228.64771352279, 5206.401263854667, 5344.527795717637, 5356.464353564613, 5379.623426360156, 5453.400125986138, 222665.0, 222878.0, 223371.0, 223502.0, 223705.0, 54304.728476358156, 54590.18114728282, 54873.45126548763, 57993.0, 58195.418045819846, 61668.383316167165, 61857.38142618516, 61937.69031154906, 61941.0, 62149.37850621526, 17503.562410939572, 17539.473815785546, 17784.377546786058, 17856.9107154466, 17885.0, 14397.496087636882, 14499.565013049625, 14505.564833055025, 14520.273986300643, 14585.0, 16384.26270817816, 16410.671786564442, 16496.67006659884, 16556.75164872528, 16642.75035874463, 6226.25284965798, 6320.873582528324, 6383.680815959184, 6395.42441180296, 6398.776042838478, 1095.775366049958, 1102.4212288548415, 1106.0985296982933, 1115.1413411672966, 1115.3865374044244, 26142.0, 26817.0, 26820.195394138205, 26897.596536051973, 26969.460610787675, 1188.441432526711, 1189.2448295332526, 1192.0642295797757, 1192.2488832035936, 1212.6180253220207, 13807.450170453092, 14069.085509441853, 14121.646958825906, 14236.644083897778, 14271.215083170526, 310215.0, 313577.0, 313912.0, 314063.0, 314125.0, 59865.0, 61771.69114154491, 65316.346836531025, 65347.0, 65367.67316163389, 1504.1125735815922, 1528.4955964531455, 1537.6232822958448, 1538.0771537077887, 1544.3359355477253, 31416.37167256688, 31717.841410792797, 31866.840665796524, 32041.198970025936, 32477.350452990337, 44049.55950440583, 44394.334084989394, 44503.10993780171, 44517.0, 44522.77738611286, 271222.0, 272738.0, 273874.0, 273876.0, 274063.0, 37342.2531549362, 38596.22807543889, 38797.80601096976, 39092.41361379639, 39161.41257881191, 49879.501204988934, 50220.74889625528, 50368.0, 50402.495975041245, 51095.0, 35626.46560301649, 35744.64255357413, 35914.46128308025, 36204.45693314655, 36580.0, 35939.0, 36126.458103127945, 36297.27405451823, 36788.0, 36812.0, 41984.37023444712, 43060.78469607632, 43061.56938430575, 43077.56922430736, 43312.566874330856, 34598.30803383968, 35110.64889351074, 35196.64803352036, 35213.47179792254, 35216.82391588025, 25567.87216063908, 26374.868125660018, 26601.733982659927, 26736.19791406261, 26958.191254262405], "value": 19612.13268628923, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.0373202515377, 642.0639722097541, 643.6844576616058, 645.2785157611976, 647.0286075549234, 23701.170459033914, 24423.63364549531, 24426.75573244267, 24465.388365290877, 24470.14354497593, 26400.20799376017, 26569.202923912315, 26685.199444016664, 26698.466030679374, 26720.732792672068, 6096.298925623543, 6298.055291706258, 6539.803805885807, 6567.6059436433725, 6570.967145164292, 6513.869722605545, 6609.537332386735, 6613.470922326226, 6617.768378106767, 6620.139381880349, 6403.263624683151, 6559.180102487189, 6563.3108523604815, 6575.178102737158, 6641.037049627826, 6581.2760596334365, 6611.471082313427, 6612.140421745166, 6613.305602911673, 6615.569987950767, 6139.478144357735, 6152.87694246117, 6180.289266734293, 6197.6901154942525, 6199.256089269272, 28814.423711525862, 30437.391252175054, 30835.383292334252, 30931.0, 30939.38121237585, 2209.657503087008, 2256.898439570223, 2260.5704916065893, 2266.909323627053, 2266.9319920402413, 20693.68959465609, 21334.67997980016, 21508.569828603497, 21539.0, 21570.676439853414, 2577.896884124633, 2604.817662763607, 2683.315754482614, 2686.422419179866, 2691.206094202215, 126591.0, 132530.0, 163513.0, 168228.15885920613, 168712.0, 16577.668446631, 17306.394276200273, 17308.480745577654, 17477.7378339325, 17511.912440437973, 27001.594976075376, 27169.592456113172, 27275.454490910466, 27286.727132728814, 27288.0, 10494.527746251437, 10598.470076496144, 10626.734331641615, 10673.252872298865, 10817.593712817441, 9513.0, 9516.904830951602, 9653.517324133905, 9680.806383872283, 9695.369800962915, 9649.517524123767, 9767.023297670175, 9951.900480995242, 10107.444090574942, 10143.594256229668, 2913.592097106407, 2940.1473572664117, 3047.49716296813, 3060.9846950765104, 3062.555929390226, 1042.9739256518496, 1043.7599352149048, 1045.7124290819934, 1054.3779170289565, 1056.7199692081604, 20949.581008379748, 21740.0, 21905.342839714835, 22110.447238819157, 22233.0, 1089.2484185911696, 1100.4662738571785, 1112.6773235761539, 1113.7494063835572, 1114.6043154679971, 11662.825057624143, 11906.166568340306, 12087.214331068453, 12140.69648258783, 12246.755064898653, 624187.0, 625428.0, 630412.0, 643110.0, 662247.0, 134443.32778336047, 136897.0, 137467.31266343605, 138358.30820846034, 139202.0, 1211.8121691137887, 1260.5525038611345, 1293.1723696834033, 1319.81522586836, 1331.8401791785047, 23222.767772322062, 23441.179558715365, 23489.765102348756, 23540.411489712893, 23616.0, 65443.34556654563, 65665.67167164134, 65925.67037164976, 68133.0, 68184.0, 80881.0, 81319.0, 81610.0, 81746.0, 83599.0, 16064.0, 16291.103989280704, 16343.59141021484, 16418.507444776675, 16491.422800201934, 22243.332700019026, 22309.553808924054, 22418.215362462237, 22549.323520294416, 24930.501389971738, 19533.609327813647, 19806.70289945623, 19993.50016249547, 20109.0, 20118.497037573594, 17249.655006900044, 17638.82361176423, 17810.376636817648, 18362.540936476697, 18386.724199136755, 20061.197552098336, 20140.79859201448, 20370.490737731674, 20455.693164602246, 20676.793232067488, 15950.0, 16145.515634530982, 16249.512514624581, 16266.105364205083, 16324.18379081065, 20058.0, 20061.899690501454, 20126.29557965464, 20171.294004709765, 20241.0], "value": 13068.491837930953, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.3282157386027, 1475.1591592792106, 1500.549835049485, 1509.4188737336126, 1517.6964607078587, 16782.244798984044, 17482.300707971666, 17525.29898804048, 17527.12364381782, 17535.912320438412, 17087.48737537873, 17145.657086858257, 17167.570810729707, 17169.055701936388, 17229.569260768454, 2877.2950627096393, 2877.7985541012135, 2919.0367178830934, 2926.868290926903, 2944.749696275808, 2870.985645071782, 2895.4353900989317, 2918.4746745585785, 2928.2386579489275, 2946.602208701819, 2875.683674795771, 2966.31774691821, 2977.746891514224, 2978.910632681023, 2979.85100744963, 2870.339821840978, 2874.2957975295976, 2901.7579010850404, 2910.694377090417, 2912.3738396244908, 2858.099698594957, 2870.2680816391894, 2876.1802886177547, 2879.9424011519864, 2887.2060183449507, 16425.0, 16832.410865619768, 16856.662866742598, 16871.57821054471, 16931.3227470901, 8326.292265157468, 8601.870971935426, 8638.0, 8654.87017694735, 8671.349648776304, 5480.601671529241, 5659.207710920475, 5762.279715035621, 5780.537556995472, 5796.42035796417, 2058.372196480073, 2196.4508872781803, 2562.2057162279752, 2694.286014206237, 2703.229579569833, 31380.21549461259, 31808.204794880083, 31814.681853181173, 31940.0, 31944.361112777846, 7746.612669366509, 7927.3658107351275, 7988.520688758693, 8080.797980050545, 8123.0, 23589.174378896998, 23621.173258935854, 23623.88188059049, 23651.763482364957, 23655.172068977503, 8822.691205807765, 9003.279737620975, 9045.231155351737, 9057.81884362309, 9058.184763371328, 7799.181085986003, 8104.311133553596, 8113.432059755761, 8137.186281371815, 8144.14486478923, 6283.59156654816, 6346.746130154835, 6395.392437718409, 6409.519286053564, 6534.57525260866, 1928.758905136858, 1989.09496179241, 1989.6219718253485, 2002.6895831146196, 2054.096197673019, 946.8674385586023, 951.5908159491485, 953.4517652349926, 959.2901253072675, 980.6616717232686, 8430.283425908867, 8468.576571171418, 8510.659573616986, 8537.743867683856, 8618.224359807647, 790.3361176611673, 803.1085495100434, 816.6284340625001, 818.6111596991382, 829.2329595124606, 5023.246513023076, 5517.724113794295, 5606.775728970877, 5782.335031471351, 5846.561507886926, 23279.650805237936, 25350.0, 25626.359341016625, 25660.973561057348, 25674.48651026969, 23943.161989330638, 24710.258692239262, 24967.126150585005, 25308.746912530638, 25343.873280633477, 11038.392888391216, 11532.769344613062, 12574.622761317176, 12779.361031948365, 13033.47866085384, 9176.495292758962, 9362.20421264173, 9383.01478344764, 9397.342186046912, 9435.952820235854, 21427.357179284645, 21537.24619638368, 21794.455138621026, 21850.562988740454, 22475.10099595998, 22171.0, 22389.66415503801, 22659.546809064057, 22762.317130486113, 22884.199053033062, 13964.930175349058, 13970.580882573538, 14138.22239776781, 14157.009009369245, 14206.0, 15307.770383444034, 15331.693366132838, 15382.769258461356, 15401.84598154049, 15433.151176685391, 12590.811137833123, 12772.744545109232, 12787.36063196855, 12812.61562153137, 13007.414666340226, 12374.690632734253, 12711.80932285998, 12777.616671499869, 12832.29422381778, 12838.0, 10427.21795865298, 10489.737756556147, 10539.473026348805, 10545.103666188154, 10613.150947923994, 7821.608919553886, 7856.410769192219, 7860.764177074697, 8045.074816395955, 8053.436259462016, 7954.2117705611545, 7963.761087167394, 8020.759377218693, 8045.477043992122, 8065.354771618374], "value": 7495.562280107223, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.771015028763, 558.8351436326284, 582.0977484898408, 583.0583607473931, 583.1748076471793, 6034.8793024139495, 6096.0, 6146.139540464339, 6146.446819786218, 6199.814005579834, 5932.139839723238, 6013.767177728566, 6026.758929642809, 6079.8176054718315, 6160.537959653022, 4829.806807727704, 4992.975035124819, 5003.774830132653, 5023.799048038074, 5038.7984480620735, 4934.679245849026, 4967.453580106186, 4979.875503112415, 5005.57452616528, 5012.248162775594, 4886.9511304886855, 4944.1594928862, 4959.280904268879, 4987.8254261100865, 5004.974975125119, 4889.804407823683, 4926.507349265081, 4931.50684931504, 4940.5800506956775, 4977.950220497785, 4552.68131230814, 4561.885952851172, 4569.840055598038, 4582.312653102028, 4625.583697467244, 5968.0, 6079.787207447718, 6091.451769340781, 6116.296625888035, 6166.8766624667705, 5792.362840087587, 5814.709264536798, 5815.505682017034, 5850.561207909382, 5856.736446859902, 6594.208694956588, 6600.2409722882, 6615.669216539154, 6643.269240383603, 6646.83382915431, 4866.148424025781, 5103.413107492649, 5113.693178409308, 5118.360204974379, 5132.538071573539, 6620.503462240351, 6624.436922861562, 6721.764738234138, 6736.629485378351, 6754.527183097185, 5148.845534633967, 5166.121759300928, 5199.428062913076, 5201.089809283436, 5210.296609957683, 5231.450697676765, 5242.895142097137, 5249.527542521191, 5284.445133261029, 5318.0, 5743.62666426681, 5823.475887170175, 5825.475707186289, 5829.88340233193, 5839.678817664984, 6540.59377233897, 6575.934240657628, 6615.270081891471, 6645.933540664628, 6659.602543084486, 1813.2565648084221, 1813.673538763009, 1818.1545581304492, 1828.1590468384693, 1833.6332733453362, 1247.6257122863105, 1302.1470936536584, 1313.6847156682327, 1328.448693792085, 1333.5732565579115, 5946.167536544887, 6005.939940600625, 6012.939870601325, 6017.578769486094, 6107.328193898667, 6488.0, 6501.772437964649, 6539.411452969161, 6551.836204094936, 6568.573042752301, 5977.970110149421, 5985.610935289193, 5987.9101813472835, 6021.397860213943, 6062.605930614496, 3435.1927297085167, 3455.3607582596796, 3463.7402194834985, 3473.0, 3493.6681015303507, 6797.6601169941305, 6829.565791183808, 6878.211664967044, 6885.311468853175, 6910.099722576231, 6757.189137303555, 6803.081583986197, 6822.4200942919415, 6835.624040677811, 6838.213605435439, 6676.265610782712, 6807.21717002551, 6859.0, 6898.241193468714, 6949.270326615733, 6491.156149700509, 6527.3472652734345, 6549.96725016391, 6554.901676474952, 6589.7364105435245, 6591.0, 6603.7688680895935, 6612.801615951529, 6616.603003819786, 6651.068850360856, 6851.177858656793, 6851.9657401712675, 6881.0, 6934.757283495053, 6935.89596156048, 5190.117679994334, 5202.8959420812125, 5209.791608335624, 5225.764840582106, 5228.921566176587, 6424.325445828121, 6529.542931994714, 6623.900641490478, 6664.233613134552, 6667.66661666905, 5991.400859913973, 6442.194725659293, 6457.418832305115, 6458.160439142881, 6481.384268494486, 6311.084892690626, 6347.96826015867, 6442.742290308523, 6454.386833250834, 6521.510886683613, 6199.969000154971, 6258.155149054819, 6292.622442653455, 6302.401271879165, 6320.810375688737, 6434.485241180788, 6452.290248072614, 6460.0, 6469.350315669474, 6480.99089282324, 6290.056491526308, 6294.527910406646, 6351.460125889351, 6351.587146835441, 6380.553361264667], "value": 5113.70322893616, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [972.8297547929113, 989.4656885281948, 994.960266521485, 995.2137811129209, 997.9251556133289, 20318.0, 21040.053197606125, 21048.89475552622, 21068.367948961557, 21308.254211102616, 19145.712814307797, 19352.322668706598, 19367.806321936776, 19462.0, 19472.513187170327, 1067.0769784136724, 1080.61638118468, 1081.2701426537096, 1081.967540973768, 1082.7509672775266, 1065.8188108021654, 1112.8386383974319, 1116.681745702475, 1117.0560876059717, 1117.8770335263155, 1148.62095508482, 1152.268309623391, 1152.3489228585863, 1152.9942350288236, 1153.9826902596467, 1139.680889350983, 1150.0512077535982, 1151.9769604607945, 1154.7113221694535, 1157.3171828621112, 847.6270441006, 849.290842146802, 850.4684572142411, 850.5874650794422, 851.1786126388065, 20170.19319227229, 20199.0, 21055.5788884223, 21374.679379809317, 21558.461038474008, 22812.08751649932, 23162.0, 23516.412089697893, 23624.527509449716, 23643.172488962802, 17789.73315400257, 17853.7321940171, 18082.186301616326, 18109.637807243915, 18134.90932545342, 3927.0575061985205, 3999.1801680655394, 4003.019260281221, 4003.799810009517, 4004.619561141687, 164841.17579412146, 167074.99999999878, 168291.0, 169557.0, 170668.14665926716, 15531.45639902598, 15794.763078553831, 15872.841271587367, 15899.0, 15958.521244362688, 32754.672453275638, 33565.664343356744, 33873.491897621556, 33949.83025084859, 34093.318133637185, 9063.32025098107, 9153.313501487415, 9191.264698824078, 9300.0, 9453.196478299284, 4710.69380490267, 4786.042791441726, 4789.3294938708605, 4797.280407938767, 4800.567948884617, 6098.847528811726, 6129.356417576179, 6157.0, 6186.876262474725, 6193.907091393633, 1032.6798692405378, 1042.994785026085, 1049.816282150636, 1050.648032908984, 1056.730533713898, 686.2348481443255, 699.8810202265627, 709.1065257775138, 714.9034880291198, 724.5181954000636, 12545.247285162919, 12556.30940298274, 12975.94090046924, 13034.80447793284, 13093.345332733325, 694.1704662927752, 695.9199692035379, 697.6546609428264, 702.8945658151318, 709.9918116274902, 6063.818085457443, 6070.969645151746, 6080.452759251689, 6107.908381374283, 6163.476104531075, 157760.0, 158503.0, 159446.0, 160215.19892400462, 160712.0, 137642.0, 138502.0, 142902.28548857188, 144158.0, 145267.0, 118133.0, 121546.3922680381, 121919.0, 122026.38986805186, 123458.0, 11445.198836081394, 11467.31196128235, 11495.712607184887, 11705.0, 11887.405629718653, 60079.0, 60613.69693151506, 61117.08324375049, 61150.69424652848, 61586.0, 75857.0, 75910.62044689742, 76743.2325676736, 77460.0, 79596.0, 16273.104979226257, 16467.67064658676, 16481.752773708642, 16723.749143763096, 16762.832371676126, 19069.618607627493, 19131.426057218305, 19180.616387672446, 19374.0, 19540.902295489, 15373.846261537241, 15804.130772807606, 15876.285567149736, 15912.681746364777, 15969.44106956251, 17095.7435638468, 17202.0, 17209.139543023048, 17287.827121729126, 17358.132093395026, 15999.960002599793, 16027.919860400623, 16102.43641472543, 16238.188090595188, 16253.349866005228, 12449.813252801396, 12511.786863571877, 12659.556915507914, 12832.679183020125, 12834.0, 12117.0, 12132.575359862716, 12230.87769122333, 12741.17182383142, 12755.298458584866], "value": 9865.097366795186, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1371.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 106.0, 104.0, 105.0, 105.0, 109.0, 107.0, 107.0, 107.0, 108.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 111.0, 111.0, 116.0, 115.0, 115.0, 113.0, 113.0, 112.0], "value": 113.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 161.0, 162.0, 160.0, 161.0, 162.0, 164.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 74.0, 74.0, 73.0, 74.0, 74.0, 72.0, 74.0, 75.0, 73.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 83.0, 78.0, 77.0, 77.0, 78.0, 78.0, 79.0, 78.0], "value": 78.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 121.0, 112.0, 116.0, 112.0, 117.0, 113.0, 111.0, 117.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 152.0, 150.0, 150.0, 150.0, 152.0, 149.0, 150.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 96.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 44.0, 45.0, 46.0, 46.0, 44.0, 44.0, 44.0, 43.0, 48.0], "value": 44.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 39.0, 39.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 76.0, 73.0, 74.0, 72.0, 71.0, 72.0, 70.0, 74.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 105.0, 106.0, 108.0, 109.0, 102.0, 104.0, 109.0, 116.0], "value": 107.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 154.0, 151.0, 153.0, 156.0, 157.0, 157.0, 150.0, 156.0, 149.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 62.0, 60.0, 58.0, 62.0, 58.0, 60.0, 57.0, 59.0], "value": 61.0, "unit": "score"}]}]} 04:34:27 INFO - Return code: 0 04:34:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:34:27 INFO - # TBPL SUCCESS # 04:34:27 INFO - Running post-action listener: _package_coverage_data 04:34:27 INFO - Running post-action listener: _resource_record_post_action 04:34:27 INFO - [mozharness: 2017-09-29 11:34:27.761744Z] Finished run-tests step (success) 04:34:27 INFO - Running post-run listener: _resource_record_post_run 04:34:27 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 322465792; Read time: 0; Write time: 260540 04:34:27 INFO - TinderboxPrint: CPU usage
13.1% 04:34:27 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:34:27 INFO - TinderboxPrint: I/O write bytes / time
322,465,792 / 260,540 04:34:27 INFO - TinderboxPrint: CPU idle
8,198.0 (86.9%) 04:34:27 INFO - TinderboxPrint: CPU user
1,186.0 (12.6%) 04:34:27 INFO - TinderboxPrint: Swap in / out
0 / 0 04:34:27 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13107200; Read time: 0; Write time: 1516 04:34:27 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:34:27 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 0; Write bytes: 309358592; Read time: 0; Write time: 259024 04:34:28 INFO - Running post-run listener: _upload_blobber_files 04:34:28 INFO - Blob upload gear active. 04:34:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:34:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:34:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:34:28 INFO - (blobuploader) - INFO - Open directory for files ... 04:34:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:34:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:34:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:30 INFO - (blobuploader) - INFO - Done attempting. 04:34:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:34:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:34:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:30 INFO - (blobuploader) - INFO - Done attempting. 04:34:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:34:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:34:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:34 INFO - (blobuploader) - INFO - Done attempting. 04:34:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:34:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:34:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:35 INFO - (blobuploader) - INFO - Done attempting. 04:34:35 INFO - (blobuploader) - INFO - Iteration through files over. 04:34:35 INFO - Return code: 0 04:34:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:34:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:34:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98822eda1879068d2a293b504051059166dd8b317fb084fe8043556aa18f12a25c1a094b708dcd82dd75af8a21455814156f161822be76079a4272a06c7bd84e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c08454459c242eb4a5f40b96ea72f029827dd942e40db8428ae011ce44ff1d6cc3f45a798ca6ef5f066f31a0cbd634d25d5b78964873e90e9846a668940ff0f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ea2cc45067b2748d97d3929d92e5dd6d14cdbad16c7675b62d4b0ae1ec5021c7209855b5fc011ea375b2a85c934dd938c19188f06ebd4794f201a558c519ad8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02425b3c7d61072086a9d2df5995a9a02e05b1bda5c570539e98d5cc4d27b1adbb756a23d9fee1b5851fe757f98216f842218d6c80127071f888a1c8bee877e8"} 04:34:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:34:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:34:35 INFO - Contents: 04:34:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98822eda1879068d2a293b504051059166dd8b317fb084fe8043556aa18f12a25c1a094b708dcd82dd75af8a21455814156f161822be76079a4272a06c7bd84e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c08454459c242eb4a5f40b96ea72f029827dd942e40db8428ae011ce44ff1d6cc3f45a798ca6ef5f066f31a0cbd634d25d5b78964873e90e9846a668940ff0f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ea2cc45067b2748d97d3929d92e5dd6d14cdbad16c7675b62d4b0ae1ec5021c7209855b5fc011ea375b2a85c934dd938c19188f06ebd4794f201a558c519ad8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02425b3c7d61072086a9d2df5995a9a02e05b1bda5c570539e98d5cc4d27b1adbb756a23d9fee1b5851fe757f98216f842218d6c80127071f888a1c8bee877e8"} 04:34:35 INFO - Running post-run listener: copy_logs_to_upload_dir 04:34:35 INFO - Copying logs to upload dir... 04:34:35 INFO - mkdir: /builds/slave/test/build/upload/logs 04:34:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.604518 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2017-09-29 04:34:35.603451) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 04:34:35.611334) ========= 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=62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98822eda1879068d2a293b504051059166dd8b317fb084fe8043556aa18f12a25c1a094b708dcd82dd75af8a21455814156f161822be76079a4272a06c7bd84e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c08454459c242eb4a5f40b96ea72f029827dd942e40db8428ae011ce44ff1d6cc3f45a798ca6ef5f066f31a0cbd634d25d5b78964873e90e9846a668940ff0f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ea2cc45067b2748d97d3929d92e5dd6d14cdbad16c7675b62d4b0ae1ec5021c7209855b5fc011ea375b2a85c934dd938c19188f06ebd4794f201a558c519ad8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02425b3c7d61072086a9d2df5995a9a02e05b1bda5c570539e98d5cc4d27b1adbb756a23d9fee1b5851fe757f98216f842218d6c80127071f888a1c8bee877e8"} build_url:https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/OsRU9v7_RyaOclVwZfen8Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98822eda1879068d2a293b504051059166dd8b317fb084fe8043556aa18f12a25c1a094b708dcd82dd75af8a21455814156f161822be76079a4272a06c7bd84e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c08454459c242eb4a5f40b96ea72f029827dd942e40db8428ae011ce44ff1d6cc3f45a798ca6ef5f066f31a0cbd634d25d5b78964873e90e9846a668940ff0f", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ea2cc45067b2748d97d3929d92e5dd6d14cdbad16c7675b62d4b0ae1ec5021c7209855b5fc011ea375b2a85c934dd938c19188f06ebd4794f201a558c519ad8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02425b3c7d61072086a9d2df5995a9a02e05b1bda5c570539e98d5cc4d27b1adbb756a23d9fee1b5851fe757f98216f842218d6c80127071f888a1c8bee877e8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-29 04:34:35.640164) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:34:35.640540) ========= 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=62c568580acbfdaac3eec7be000001dc-1506682078.320547-352863375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-29 04:34:35.722765) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 04:34:35.723146) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-29 04:34:35.723535) ========= ========= Total master_lag: 0.46 =========