builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-057 starttime: 1505817003.32 results: success (0) revision: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:03.321088) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:03.321498) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:03.321772) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:03.398195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:03.398534) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-19 03:30:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-09-19 03:30:03 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095501 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:03.511647) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:03.511955) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019327 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:03.567808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:03.568148) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 --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 e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 --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=934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-19 03:30:03,619 truncating revision to first 12 chars 2017-09-19 03:30:03,619 Setting DEBUG logging. 2017-09-19 03:30:03,619 attempt 1/10 2017-09-19 03:30:03,619 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e4261f5b96eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-19 03:30:04,049 unpacking tar archive at: mozilla-central-e4261f5b96eb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.750033 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:04.334176) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:04.334484) ========= script_repo_revision: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:04.334859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:04.335135) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 03:30:04.349193) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-19 03:30:04.349469) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:04 INFO - MultiFileLogger online at 20170919 03:30:04 in /builds/slave/test 03:30:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:30:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:04 INFO - {'append_to_log': False, 03:30:04 INFO - 'base_work_dir': '/builds/slave/test', 03:30:04 INFO - 'blob_upload_branch': 'Firefox', 03:30:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:04 INFO - 'branch': 'Firefox', 03:30:04 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:04 INFO - 'code_coverage': False, 03:30:04 INFO - 'config_files': ('talos/linux_config.py',), 03:30:04 INFO - 'default_actions': ('clobber', 03:30:04 INFO - 'read-buildbot-config', 03:30:04 INFO - 'download-and-extract', 03:30:04 INFO - 'populate-webroot', 03:30:04 INFO - 'create-virtualenv', 03:30:04 INFO - 'install', 03:30:04 INFO - 'setup-mitmproxy', 03:30:04 INFO - 'run-tests'), 03:30:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:04 INFO - 'disable_ccov_upload': False, 03:30:04 INFO - 'disable_stylo': False, 03:30:04 INFO - 'download_minidump_stackwalk': True, 03:30:04 INFO - 'download_symbols': 'ondemand', 03:30:04 INFO - 'enable_stylo': False, 03:30:04 INFO - 'enable_webrender': False, 03:30:04 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:30:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:04 INFO - 'gecko_profile': False, 03:30:04 INFO - 'gecko_profile_interval': 0, 03:30:04 INFO - 'installer_path': 'installer.exe', 03:30:04 INFO - 'log_level': 'info', 03:30:04 INFO - 'log_name': 'talos', 03:30:04 INFO - 'log_to_console': True, 03:30:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:04 INFO - 'opt_config_files': (), 03:30:04 INFO - 'pip_index': False, 03:30:04 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:30:04 INFO - 'system_bits': '32', 03:30:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:04 INFO - 'title': 'talos-linux64-ix-057', 03:30:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:04 INFO - 'use_talos_json': True, 03:30:04 INFO - 'verify': 'False', 03:30:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:04 INFO - 'work_dir': 'build'} 03:30:04 INFO - [mozharness: 2017-09-19 10:30:04.548002Z] Running clobber step. 03:30:04 INFO - Running pre-action listener: _resource_record_pre_action 03:30:04 INFO - Running main action method: clobber 03:30:04 INFO - rmtree: /builds/slave/test/build 03:30:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:06 INFO - Running post-action listener: _resource_record_post_action 03:30:06 INFO - [mozharness: 2017-09-19 10:30:06.050740Z] Finished clobber step (success) 03:30:06 INFO - [mozharness: 2017-09-19 10:30:06.050837Z] Running read-buildbot-config step. 03:30:06 INFO - Running pre-action listener: _resource_record_pre_action 03:30:06 INFO - Running main action method: read_buildbot_config 03:30:06 INFO - Using buildbot properties: 03:30:06 INFO - { 03:30:06 INFO - "project": "", 03:30:06 INFO - "product": "firefox", 03:30:06 INFO - "who": "archaeopteryx@coole-files.de", 03:30:06 INFO - "installer_path": "public/build/target.tar.bz2", 03:30:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:30:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:30:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 03:30:06 INFO - "stage_platform": "linux64-pgo", 03:30:06 INFO - "basedir": "/builds/slave/test", 03:30:06 INFO - "buildnumber": 30, 03:30:06 INFO - "platform": "ubuntu64_hw", 03:30:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:30:06 INFO - "slavebuilddir": "test", 03:30:06 INFO - "taskId": "DpvoFxhARBum9KJicZqKNA", 03:30:06 INFO - "branch": "mozilla-central", 03:30:06 INFO - "script_repo_revision": "production", 03:30:06 INFO - "revision": "e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5", 03:30:06 INFO - "slavename": "talos-linux64-ix-057", 03:30:06 INFO - "repo_path": "mozilla-central" 03:30:06 INFO - } 03:30:06 INFO - Finding installer, test and symbols from parent task. 03:30:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpvoFxhARBum9KJicZqKNA'}, attempt #1 03:30:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpvoFxhARBum9KJicZqKNA'}, attempt #1 03:30:06 INFO - Task dependencies: Y9n31viyR8mh7pkqvQO0YA 03:30:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA'}, attempt #1 03:30:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2 03:30:07 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.test_packages.json 03:30:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.crashreporter-symbols.zip 03:30:07 INFO - Running post-action listener: _resource_record_post_action 03:30:07 INFO - [mozharness: 2017-09-19 10:30:07.356777Z] Finished read-buildbot-config step (success) 03:30:07 INFO - [mozharness: 2017-09-19 10:30:07.356992Z] Running download-and-extract step. 03:30:07 INFO - Running pre-action listener: _resource_record_pre_action 03:30:07 INFO - Running main action method: download_and_extract 03:30:07 INFO - mkdir: /builds/slave/test/build/tests 03:30:07 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')]} 03:30:07 INFO - trying https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.test_packages.json 03:30:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:30:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:30:07 INFO - Downloaded 989 bytes. 03:30:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:30:07 INFO - Using the following test package requirements: 03:30:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:30:07 INFO - u'common': [u'target.common.tests.zip'], 03:30:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:30:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:30:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:30:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:30:07 INFO - u'mozbase': [u'target.common.tests.zip'], 03:30:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:30:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:30:07 INFO - u'web-platform': [u'target.common.tests.zip', 03:30:07 INFO - u'target.web-platform.tests.tar.gz'], 03:30:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:30:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:30:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.common.tests.zip 03:30:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:30:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.common.tests.zip into memory 03:30:09 INFO - Content-Length response header: 55327111 03:30:09 INFO - Bytes received: 55327111 03:30:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.talos.tests.zip 03:30:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:30:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.talos.tests.zip into memory 03:30:21 INFO - Content-Length response header: 14508787 03:30:21 INFO - Bytes received: 14508787 03:30:21 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')]} 03:30:21 INFO - trying https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2 03:30:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:30:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:30:24 INFO - Downloaded 62293283 bytes. 03:30:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2 03:30:24 INFO - mkdir: /builds/slave/test/properties 03:30:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:30:24 INFO - Writing to file /builds/slave/test/properties/build_url 03:30:24 INFO - Contents: 03:30:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2 03:30:24 INFO - Running post-action listener: _resource_record_post_action 03:30:24 INFO - Running post-action listener: find_tests_for_verification 03:30:24 INFO - Running post-action listener: set_extra_try_arguments 03:30:24 INFO - [mozharness: 2017-09-19 10:30:24.207611Z] Finished download-and-extract step (success) 03:30:24 INFO - [mozharness: 2017-09-19 10:30:24.207836Z] Running populate-webroot step. 03:30:24 INFO - Running pre-action listener: _resource_record_pre_action 03:30:24 INFO - Running main action method: populate_webroot 03:30:24 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:30:24 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['tresize', 03:30:24 INFO - 'tcanvasmark']}, 03:30:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:30:24 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['dromaeo_css', 03:30:24 INFO - 'kraken']}, 03:30:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:24 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'tests': ['damp', 'tps']}, 03:30:24 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['damp', 'tps']}, 03:30:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:30:24 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['dromaeo_dom']}, 03:30:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:30:24 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['basic_compositor_video', 03:30:24 INFO - 'glvideo']}, 03:30:24 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:30:24 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['ts_paint_webext', 03:30:24 INFO - 'tp5o_webext']}, 03:30:24 INFO - 'other-e10s': {'tests': ['a11yr', 03:30:24 INFO - 'ts_paint', 03:30:24 INFO - 'tpaint', 03:30:24 INFO - 'sessionrestore', 03:30:24 INFO - 'sessionrestore_many_windows', 03:30:24 INFO - 'sessionrestore_no_auto_restore', 03:30:24 INFO - 'tabpaint']}, 03:30:24 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['a11yr', 03:30:24 INFO - 'ts_paint', 03:30:24 INFO - 'tpaint', 03:30:24 INFO - 'sessionrestore', 03:30:24 INFO - 'sessionrestore_many_windows', 03:30:24 INFO - 'sessionrestore_no_auto_restore', 03:30:24 INFO - 'tabpaint']}, 03:30:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:30:24 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:30:24 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['perf_reftest_singletons']}, 03:30:24 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['bloom_basic']}, 03:30:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:30:24 INFO - 'tsvgr_opacity', 03:30:24 INFO - 'tart', 03:30:24 INFO - 'tscrollx', 03:30:24 INFO - 'tsvg_static']}, 03:30:24 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['tsvgx', 03:30:24 INFO - 'tsvgr_opacity', 03:30:24 INFO - 'tart', 03:30:24 INFO - 'tscrollx', 03:30:24 INFO - 'tsvg_static']}, 03:30:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:30:24 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'talos_options': ['--disable-stylo'], 03:30:24 INFO - 'tests': ['tp5o']}, 03:30:24 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:30:24 INFO - 'talos_options': ['--mitmproxy', 03:30:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:30:24 INFO - '--firstNonBlankPaint'], 03:30:24 INFO - 'tests': ['tp6_google', 03:30:24 INFO - 'tp6_youtube', 03:30:24 INFO - 'tp6_amazon', 03:30:24 INFO - 'tp6_facebook']}, 03:30:24 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:30:24 INFO - 'talos_options': ['--disable-stylo', 03:30:24 INFO - '--mitmproxy', 03:30:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:30:24 INFO - '--firstNonBlankPaint'], 03:30:24 INFO - 'tests': ['tp6_google', 03:30:24 INFO - 'tp6_youtube', 03:30:24 INFO - 'tp6_amazon', 03:30:24 INFO - 'tp6_facebook']}, 03:30:24 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:30:24 INFO - 'talos_options': ['--stylo-threads=1', 03:30:24 INFO - '--mitmproxy', 03:30:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:30:24 INFO - '--firstNonBlankPaint'], 03:30:24 INFO - 'tests': ['tp6_google', 03:30:24 INFO - 'tp6_youtube', 03:30:24 INFO - 'tp6_amazon', 03:30:24 INFO - 'tp6_facebook']}, 03:30:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'talos_options': ['--xperf_path', 03:30:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:24 INFO - 'tests': ['tp5n']}, 03:30:24 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:30:24 INFO - 'talos_options': ['--disable-stylo', 03:30:24 INFO - '--xperf_path', 03:30:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:24 INFO - 'tests': ['tp5n']}}} 03:30:24 INFO - Running post-action listener: _resource_record_post_action 03:30:24 INFO - [mozharness: 2017-09-19 10:30:24.232369Z] Finished populate-webroot step (success) 03:30:24 INFO - [mozharness: 2017-09-19 10:30:24.232457Z] Running create-virtualenv step. 03:30:24 INFO - Running pre-action listener: _resource_record_pre_action 03:30:24 INFO - Running main action method: create_virtualenv 03:30:24 INFO - Creating virtualenv /builds/slave/test/build/venv 03:30:24 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:30:24 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:30:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:30:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:30:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:30:24 INFO - Installing distribute.............................................................................................................................................................................................done. 03:30:25 INFO - Installing pip...............done. 03:30:25 INFO - Return code: 0 03:30:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:30:25 INFO - Reading from file tmpfile_stdout 03:30:25 INFO - Output received: 03:30: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) 03:30:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30: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 0x22321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2090>, '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 0x25a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259cf90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', '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 03:30: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 03:30: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 03:30:25 INFO - Using env: {'DISPLAY': ':0', 03:30:25 INFO - 'HOME': '/home/cltbld', 03:30:25 INFO - 'LANG': 'en_US.UTF-8', 03:30:25 INFO - 'LANGUAGE': 'en_US:en', 03:30:25 INFO - 'LOGNAME': 'cltbld', 03:30:25 INFO - 'MAIL': '/var/mail/cltbld', 03:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:25 INFO - 'MOZ_NO_REMOTE': '1', 03:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:25 INFO - 'NO_EM_RESTART': '1', 03:30:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:25 INFO - 'PWD': '/builds/slave/test', 03:30:25 INFO - 'SHELL': '/bin/bash', 03:30:25 INFO - 'SHLVL': '1', 03:30:25 INFO - 'TERM': 'linux', 03:30:25 INFO - 'TMOUT': '86400', 03:30:25 INFO - 'USER': 'cltbld', 03:30:25 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', 03:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:25 INFO - '_': '/tools/buildbot/bin/python'} 03:30:26 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:30:26 INFO - Downloading/unpacking pip>=1.5 03:30:26 INFO - Running setup.py egg_info for package pip 03:30:26 INFO - warning: no files found matching 'pip/cacert.pem' 03:30:26 INFO - warning: no files found matching '*.html' under directory 'docs' 03:30:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:30:26 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:30:26 INFO - Installing collected packages: pip 03:30:26 INFO - Found existing installation: pip 1.1 03:30:26 INFO - Uninstalling pip: 03:30:26 INFO - Successfully uninstalled pip 03:30:26 INFO - Running setup.py install for pip 03:30:26 INFO - warning: no files found matching 'pip/cacert.pem' 03:30:26 INFO - warning: no files found matching '*.html' under directory 'docs' 03:30:26 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:30:26 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:30:26 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:30:26 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:30:26 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:30:26 INFO - Successfully installed pip 03:30:26 INFO - Cleaning up... 03:30:26 INFO - Return code: 0 03:30:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:27 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 0x22321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2090>, '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 0x25a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259cf90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', '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 03:30:27 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 03:30:27 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 03:30:27 INFO - Using env: {'DISPLAY': ':0', 03:30:27 INFO - 'HOME': '/home/cltbld', 03:30:27 INFO - 'LANG': 'en_US.UTF-8', 03:30:27 INFO - 'LANGUAGE': 'en_US:en', 03:30:27 INFO - 'LOGNAME': 'cltbld', 03:30:27 INFO - 'MAIL': '/var/mail/cltbld', 03:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:27 INFO - 'MOZ_NO_REMOTE': '1', 03:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:27 INFO - 'NO_EM_RESTART': '1', 03:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:27 INFO - 'PWD': '/builds/slave/test', 03:30:27 INFO - 'SHELL': '/bin/bash', 03:30:27 INFO - 'SHLVL': '1', 03:30:27 INFO - 'TERM': 'linux', 03:30:27 INFO - 'TMOUT': '86400', 03:30:27 INFO - 'USER': 'cltbld', 03:30:27 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', 03:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:27 INFO - '_': '/tools/buildbot/bin/python'} 03:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:27 INFO - Downloading/unpacking psutil>=3.1.1 03:30:27 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 03:30:27 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 03:30:27 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 03:30:27 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 03:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:28 INFO - Installing collected packages: psutil 03:30:28 INFO - Running setup.py install for psutil 03:30:28 INFO - building 'psutil._psutil_linux' extension 03:30: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 03:30: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 03:30:28 INFO - building 'psutil._psutil_posix' extension 03:30: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 03:30: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 03:30:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:28 INFO - Successfully installed psutil 03:30:28 INFO - Cleaning up... 03:30:28 INFO - Return code: 0 03:30:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30: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 0x22321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2090>, '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 0x25a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259cf90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', '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 03:30: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 03:30: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 03:30:28 INFO - Using env: {'DISPLAY': ':0', 03:30:28 INFO - 'HOME': '/home/cltbld', 03:30:28 INFO - 'LANG': 'en_US.UTF-8', 03:30:28 INFO - 'LANGUAGE': 'en_US:en', 03:30:28 INFO - 'LOGNAME': 'cltbld', 03:30:28 INFO - 'MAIL': '/var/mail/cltbld', 03:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:28 INFO - 'MOZ_NO_REMOTE': '1', 03:30:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:28 INFO - 'NO_EM_RESTART': '1', 03:30:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:28 INFO - 'PWD': '/builds/slave/test', 03:30:28 INFO - 'SHELL': '/bin/bash', 03:30:28 INFO - 'SHLVL': '1', 03:30:28 INFO - 'TERM': 'linux', 03:30:28 INFO - 'TMOUT': '86400', 03:30:28 INFO - 'USER': 'cltbld', 03:30:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', 03:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:28 INFO - '_': '/tools/buildbot/bin/python'} 03:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:30:29 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 03:30:29 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 03:30:29 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 03:30:29 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 03:30:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:30:30 INFO - Installing collected packages: mozsystemmonitor 03:30:30 INFO - Running setup.py install for mozsystemmonitor 03:30:30 INFO - Successfully installed mozsystemmonitor 03:30:30 INFO - Cleaning up... 03:30:30 INFO - Return code: 0 03:30:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30: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 0x22321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2090>, '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 0x25a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259cf90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', '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 03:30: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 03:30: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 03:30:30 INFO - Using env: {'DISPLAY': ':0', 03:30:30 INFO - 'HOME': '/home/cltbld', 03:30:30 INFO - 'LANG': 'en_US.UTF-8', 03:30:30 INFO - 'LANGUAGE': 'en_US:en', 03:30:30 INFO - 'LOGNAME': 'cltbld', 03:30:30 INFO - 'MAIL': '/var/mail/cltbld', 03:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:30 INFO - 'MOZ_NO_REMOTE': '1', 03:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:30 INFO - 'NO_EM_RESTART': '1', 03:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:30 INFO - 'PWD': '/builds/slave/test', 03:30:30 INFO - 'SHELL': '/bin/bash', 03:30:30 INFO - 'SHLVL': '1', 03:30:30 INFO - 'TERM': 'linux', 03:30:30 INFO - 'TMOUT': '86400', 03:30:30 INFO - 'USER': 'cltbld', 03:30:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', 03:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:30 INFO - '_': '/tools/buildbot/bin/python'} 03:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:30 INFO - Downloading/unpacking jsonschema==2.5.1 03:30:30 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 03:30:30 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 03:30:30 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 03:30:30 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 03:30:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:30:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:30: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 03:30: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 03:30: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 03:30: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 03:30:31 INFO - Downloading functools32-3.2.3-2.tar.gz 03:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:30:31 INFO - warning: no files found matching '*.txt' 03:30:31 INFO - no previously-included directories found matching 'build' 03:30:31 INFO - no previously-included directories found matching 'dist' 03:30:31 INFO - no previously-included directories found matching '.git*' 03:30:31 INFO - Installing collected packages: jsonschema, functools32 03:30:32 INFO - Running setup.py install for functools32 03:30:32 INFO - warning: no files found matching '*.txt' 03:30:32 INFO - no previously-included directories found matching 'build' 03:30:32 INFO - no previously-included directories found matching 'dist' 03:30:32 INFO - no previously-included directories found matching '.git*' 03:30:32 INFO - Successfully installed jsonschema functools32 03:30:32 INFO - Cleaning up... 03:30:32 INFO - Return code: 0 03:30:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30: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 0x22321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2090>, '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 0x25a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259cf90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', '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 03:30: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 03:30: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 03:30:32 INFO - Using env: {'DISPLAY': ':0', 03:30:32 INFO - 'HOME': '/home/cltbld', 03:30:32 INFO - 'LANG': 'en_US.UTF-8', 03:30:32 INFO - 'LANGUAGE': 'en_US:en', 03:30:32 INFO - 'LOGNAME': 'cltbld', 03:30:32 INFO - 'MAIL': '/var/mail/cltbld', 03:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:32 INFO - 'MOZ_NO_REMOTE': '1', 03:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:32 INFO - 'NO_EM_RESTART': '1', 03:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:32 INFO - 'PWD': '/builds/slave/test', 03:30:32 INFO - 'SHELL': '/bin/bash', 03:30:32 INFO - 'SHLVL': '1', 03:30:32 INFO - 'TERM': 'linux', 03:30:32 INFO - 'TMOUT': '86400', 03:30:32 INFO - 'USER': 'cltbld', 03:30:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', 03:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:32 INFO - '_': '/tools/buildbot/bin/python'} 03:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:30:32 INFO - Cleaning up... 03:30:32 INFO - Return code: 0 03:30:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30: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 0x22321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2090>, '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 0x25a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259cf90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', '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 03:30: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 03:30: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 03:30:32 INFO - Using env: {'DISPLAY': ':0', 03:30:32 INFO - 'HOME': '/home/cltbld', 03:30:32 INFO - 'LANG': 'en_US.UTF-8', 03:30:32 INFO - 'LANGUAGE': 'en_US:en', 03:30:32 INFO - 'LOGNAME': 'cltbld', 03:30:32 INFO - 'MAIL': '/var/mail/cltbld', 03:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:32 INFO - 'MOZ_NO_REMOTE': '1', 03:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:32 INFO - 'NO_EM_RESTART': '1', 03:30:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:32 INFO - 'PWD': '/builds/slave/test', 03:30:32 INFO - 'SHELL': '/bin/bash', 03:30:32 INFO - 'SHLVL': '1', 03:30:32 INFO - 'TERM': 'linux', 03:30:32 INFO - 'TMOUT': '86400', 03:30:32 INFO - 'USER': 'cltbld', 03:30:32 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', 03:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:32 INFO - '_': '/tools/buildbot/bin/python'} 03:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:32 INFO - Downloading/unpacking blobuploader==1.2.4 03:30: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 03:30: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 03:30: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 03:30: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 03:30:33 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30: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 03:30: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 03:30: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 03:30: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 03:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30: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 03:30: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 03:30: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 03:30: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 03:30:34 INFO - Downloading docopt-0.6.1.tar.gz 03:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:34 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:34 INFO - Running setup.py install for blobuploader 03:30:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:34 INFO - Running setup.py install for requests 03:30:34 INFO - Running setup.py install for docopt 03:30:34 INFO - Successfully installed blobuploader requests docopt 03:30:34 INFO - Cleaning up... 03:30:34 INFO - Return code: 0 03:30:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:34 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 0x22321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2090>, '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 0x25a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259cf90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', '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 03:30:34 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 03:30:34 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 03:30:34 INFO - Using env: {'DISPLAY': ':0', 03:30:34 INFO - 'HOME': '/home/cltbld', 03:30:34 INFO - 'LANG': 'en_US.UTF-8', 03:30:34 INFO - 'LANGUAGE': 'en_US:en', 03:30:34 INFO - 'LOGNAME': 'cltbld', 03:30:34 INFO - 'MAIL': '/var/mail/cltbld', 03:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:34 INFO - 'MOZ_NO_REMOTE': '1', 03:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:34 INFO - 'NO_EM_RESTART': '1', 03:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:34 INFO - 'PWD': '/builds/slave/test', 03:30:34 INFO - 'SHELL': '/bin/bash', 03:30:34 INFO - 'SHLVL': '1', 03:30:34 INFO - 'TERM': 'linux', 03:30:34 INFO - 'TMOUT': '86400', 03:30:34 INFO - 'USER': 'cltbld', 03:30:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', 03:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:34 INFO - '_': '/tools/buildbot/bin/python'} 03:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:35 INFO - Running setup.py (path:/tmp/pip-N9r7Mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:35 INFO - Running setup.py (path:/tmp/pip-uiGcud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:35 INFO - Running setup.py (path:/tmp/pip-2G5RCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:35 INFO - Running setup.py (path:/tmp/pip-VhlwUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:35 INFO - Running setup.py (path:/tmp/pip-RsbPBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:35 INFO - Running setup.py (path:/tmp/pip-3qt9yB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:35 INFO - Running setup.py (path:/tmp/pip-bo1GP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:35 INFO - Running setup.py (path:/tmp/pip-AzsZrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:35 INFO - Running setup.py (path:/tmp/pip-Ok6qYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:35 INFO - Running setup.py (path:/tmp/pip-0cqDBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:35 INFO - Running setup.py (path:/tmp/pip-6T_fvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:35 INFO - Running setup.py (path:/tmp/pip-3N4SII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:35 INFO - Running setup.py (path:/tmp/pip-IQAZMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:36 INFO - Running setup.py (path:/tmp/pip-8wyQCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:36 INFO - Running setup.py (path:/tmp/pip-WakNfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:36 INFO - Running setup.py (path:/tmp/pip-Q7RkQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:36 INFO - Running setup.py (path:/tmp/pip-xA_j7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:36 INFO - Running setup.py install for manifestparser 03:30:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:30:36 INFO - Running setup.py install for mozcrash 03:30:36 INFO - Running setup.py install for mozdebug 03:30:36 INFO - Running setup.py install for mozdevice 03:30:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:30:36 INFO - Running setup.py install for mozfile 03:30:36 INFO - Running setup.py install for mozhttpd 03:30:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:30:36 INFO - Running setup.py install for mozinfo 03:30:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:30:36 INFO - Running setup.py install for mozInstall 03:30:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:30:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:30:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:30:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:30:37 INFO - Running setup.py install for mozleak 03:30:37 INFO - Running setup.py install for mozlog 03:30:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:30:37 INFO - Running setup.py install for moznetwork 03:30:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:30:37 INFO - Running setup.py install for mozprocess 03:30:37 INFO - Running setup.py install for mozprofile 03:30:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:30:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:30:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:30:37 INFO - Running setup.py install for mozrunner 03:30:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:30:37 INFO - Running setup.py install for mozscreenshot 03:30:37 INFO - Running setup.py install for moztest 03:30:37 INFO - Running setup.py install for mozversion 03:30:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:30:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:38 INFO - Cleaning up... 03:30:38 INFO - Return code: 0 03:30:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30: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 0x22321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2090>, '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 0x25a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259cf90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', '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 03:30: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 03:30: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 03:30:38 INFO - Using env: {'DISPLAY': ':0', 03:30:38 INFO - 'HOME': '/home/cltbld', 03:30:38 INFO - 'LANG': 'en_US.UTF-8', 03:30:38 INFO - 'LANGUAGE': 'en_US:en', 03:30:38 INFO - 'LOGNAME': 'cltbld', 03:30:38 INFO - 'MAIL': '/var/mail/cltbld', 03:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:38 INFO - 'MOZ_NO_REMOTE': '1', 03:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:38 INFO - 'NO_EM_RESTART': '1', 03:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:38 INFO - 'PWD': '/builds/slave/test', 03:30:38 INFO - 'SHELL': '/bin/bash', 03:30:38 INFO - 'SHLVL': '1', 03:30:38 INFO - 'TERM': 'linux', 03:30:38 INFO - 'TMOUT': '86400', 03:30:38 INFO - 'USER': 'cltbld', 03:30:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', 03:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:38 INFO - '_': '/tools/buildbot/bin/python'} 03:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:38 INFO - Running setup.py (path:/tmp/pip-cs5cJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30: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)) 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:38 INFO - Running setup.py (path:/tmp/pip-K9zOOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:38 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)) 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:38 INFO - Running setup.py (path:/tmp/pip-ksLEO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:38 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)) 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:38 INFO - Running setup.py (path:/tmp/pip-zug0Co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:38 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)) 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:38 INFO - Running setup.py (path:/tmp/pip-9fAJaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:38 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)) 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:38 INFO - Running setup.py (path:/tmp/pip-5KeWe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:38 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)) 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:38 INFO - Running setup.py (path:/tmp/pip-P5vKTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:38 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)) 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:38 INFO - Running setup.py (path:/tmp/pip-YJjPJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:38 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)) 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:38 INFO - Running setup.py (path:/tmp/pip-lKsSEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:38 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)) 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:38 INFO - Running setup.py (path:/tmp/pip-Nj4TdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:38 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)) 03:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:38 INFO - Running setup.py (path:/tmp/pip-mde6bB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30: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)) 03:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:39 INFO - Running setup.py (path:/tmp/pip-7dSaap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30: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)) 03:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:39 INFO - Running setup.py (path:/tmp/pip-C_iy7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30: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)) 03:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:39 INFO - Running setup.py (path:/tmp/pip-3zmpg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30: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)) 03:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:39 INFO - Running setup.py (path:/tmp/pip-UEolls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30: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)) 03:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:39 INFO - Running setup.py (path:/tmp/pip-sIOxBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:39 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)) 03:30:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:39 INFO - Running setup.py (path:/tmp/pip-DTftZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:39 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)) 03:30:39 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)) 03:30:39 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)) 03:30:39 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)) 03:30:39 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)) 03:30:39 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)) 03:30:39 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)) 03:30:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30:39 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 03:30:39 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 03:30:39 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 03:30:39 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 03:30:40 INFO - Downloading blessings-1.6.tar.gz 03:30:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:40 INFO - Installing collected packages: blessings 03:30:40 INFO - Running setup.py install for blessings 03:30:40 INFO - Successfully installed blessings 03:30:40 INFO - Cleaning up... 03:30:40 INFO - Return code: 0 03:30:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:30:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:41 INFO - Reading from file tmpfile_stdout 03:30:41 INFO - Current package versions: 03:30:41 INFO - argparse == 1.2.1 03:30:41 INFO - blessings == 1.6 03:30:41 INFO - blobuploader == 1.2.4 03:30:41 INFO - docopt == 0.6.1 03:30:41 INFO - functools32 == 3.2.3-2 03:30:41 INFO - jsonschema == 2.5.1 03:30:41 INFO - manifestparser == 1.1 03:30:41 INFO - mozInstall == 1.13 03:30:41 INFO - mozcrash == 1.0 03:30:41 INFO - mozdebug == 0.1 03:30:41 INFO - mozdevice == 0.51 03:30:41 INFO - mozfile == 1.2 03:30:41 INFO - mozhttpd == 0.7 03:30:41 INFO - mozinfo == 0.10 03:30:41 INFO - mozleak == 0.1 03:30:41 INFO - mozlog == 3.5 03:30:41 INFO - moznetwork == 0.27 03:30:41 INFO - mozprocess == 0.25 03:30:41 INFO - mozprofile == 0.28 03:30:41 INFO - mozrunner == 6.13 03:30:41 INFO - mozscreenshot == 0.1 03:30:41 INFO - mozsystemmonitor == 0.3 03:30:41 INFO - moztest == 0.8 03:30:41 INFO - mozversion == 1.4 03:30:41 INFO - psutil == 3.1.1 03:30:41 INFO - requests == 1.2.3 03:30:41 INFO - wsgiref == 0.1.2 03:30:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30: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 0x22321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2090>, '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 0x25a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259cf90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', '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 03:30: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 03:30: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 03:30:41 INFO - Using env: {'DISPLAY': ':0', 03:30:41 INFO - 'HOME': '/home/cltbld', 03:30:41 INFO - 'LANG': 'en_US.UTF-8', 03:30:41 INFO - 'LANGUAGE': 'en_US:en', 03:30:41 INFO - 'LOGNAME': 'cltbld', 03:30:41 INFO - 'MAIL': '/var/mail/cltbld', 03:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:41 INFO - 'MOZ_NO_REMOTE': '1', 03:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:41 INFO - 'NO_EM_RESTART': '1', 03:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:41 INFO - 'PWD': '/builds/slave/test', 03:30:41 INFO - 'SHELL': '/bin/bash', 03:30:41 INFO - 'SHLVL': '1', 03:30:41 INFO - 'TERM': 'linux', 03:30:41 INFO - 'TMOUT': '86400', 03:30:41 INFO - 'USER': 'cltbld', 03:30:41 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', 03:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:41 INFO - '_': '/tools/buildbot/bin/python'} 03:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30: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)) 03:30: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)) 03:30: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)) 03:30: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)) 03:30: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)) 03:30: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)) 03:30: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)) 03:30: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)) 03:30: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)) 03:30:41 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:30: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 03:30: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 03:30: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 03:30: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 03:30:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:30:42 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)) 03:30:42 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)) 03:30:42 INFO - Installing collected packages: simplejson 03:30:42 INFO - Running setup.py install for simplejson 03:30:42 INFO - building 'simplejson._speedups' extension 03:30:42 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 03:30: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 03:30:43 INFO - Successfully installed simplejson 03:30:43 INFO - Cleaning up... 03:30:43 INFO - Return code: 0 03:30:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:30:43 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')]} 03:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:43 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')]} 03:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:43 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 0x22321f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a2090>, '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 0x25a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259cf90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', '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 03:30:43 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 03:30:43 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 03:30:43 INFO - Using env: {'DISPLAY': ':0', 03:30:43 INFO - 'HOME': '/home/cltbld', 03:30:43 INFO - 'LANG': 'en_US.UTF-8', 03:30:43 INFO - 'LANGUAGE': 'en_US:en', 03:30:43 INFO - 'LOGNAME': 'cltbld', 03:30:43 INFO - 'MAIL': '/var/mail/cltbld', 03:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:43 INFO - 'MOZ_NO_REMOTE': '1', 03:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:43 INFO - 'NO_EM_RESTART': '1', 03:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:43 INFO - 'PWD': '/builds/slave/test', 03:30:43 INFO - 'SHELL': '/bin/bash', 03:30:43 INFO - 'SHLVL': '1', 03:30:43 INFO - 'TERM': 'linux', 03:30:43 INFO - 'TMOUT': '86400', 03:30:43 INFO - 'USER': 'cltbld', 03:30:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', 03:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:43 INFO - '_': '/tools/buildbot/bin/python'} 03:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:30:43 INFO - Cleaning up... 03:30:43 INFO - Return code: 0 03:30:43 INFO - Running post-action listener: _resource_record_post_action 03:30:43 INFO - Running post-action listener: _start_resource_monitoring 03:30:43 INFO - Starting resource monitoring. 03:30:43 INFO - [mozharness: 2017-09-19 10:30:43.764189Z] Finished create-virtualenv step (success) 03:30:43 INFO - [mozharness: 2017-09-19 10:30:43.764652Z] Running install step. 03:30:43 INFO - Running pre-action listener: _resource_record_pre_action 03:30:43 INFO - Running main action method: install 03:30:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:43 INFO - Reading from file tmpfile_stdout 03:30:43 INFO - Detecting whether we're running mozinstall >=1.0... 03:30:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:30:44 INFO - Reading from file tmpfile_stdout 03:30:44 INFO - Output received: 03:30:44 INFO - Usage: mozinstall [options] installer 03:30:44 INFO - Options: 03:30:44 INFO - -h, --help show this help message and exit 03:30:44 INFO - -d DEST, --destination=DEST 03:30:44 INFO - Directory to install application into. [default: 03:30:44 INFO - "/builds/slave/test"] 03:30:44 INFO - --app=APP Application being installed. [default: firefox] 03:30:44 INFO - mkdir: /builds/slave/test/build/application 03:30: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'] 03:30:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:31:01 INFO - Reading from file tmpfile_stdout 03:31:01 INFO - Output received: 03:31:01 INFO - /builds/slave/test/build/application/firefox/firefox 03:31:01 INFO - Running post-action listener: _resource_record_post_action 03:31:01 INFO - [mozharness: 2017-09-19 10:31:01.738093Z] Finished install step (success) 03:31:01 INFO - [mozharness: 2017-09-19 10:31:01.738213Z] Running setup-mitmproxy step. 03:31:01 INFO - Running pre-action listener: _resource_record_pre_action 03:31:01 INFO - Running main action method: setup_mitmproxy 03:31:01 INFO - Skipping: mitmproxy is not required 03:31:01 INFO - Running post-action listener: _resource_record_post_action 03:31:01 INFO - [mozharness: 2017-09-19 10:31:01.738736Z] Finished setup-mitmproxy step (success) 03:31:01 INFO - [mozharness: 2017-09-19 10:31:01.738838Z] Running run-tests step. 03:31:01 INFO - Running pre-action listener: _resource_record_pre_action 03:31:01 INFO - Running pre-action listener: _set_gcov_prefix 03:31:01 INFO - Running main action method: run_tests 03:31:01 WARNING - Try message not found. 03:31:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:31:01 INFO - Python 2.7.3 03:31:01 INFO - Return code: 0 03:31:01 INFO - grabbing minidump binary from tooltool 03:31:01 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')]} 03:31:01 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 0x25a2090>, '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 0x25a2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x259cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:31:01 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 03:31:01 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 03:31:01 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 03:31:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:31:01 INFO - Return code: 0 03:31:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:31:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:31:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:31:01 INFO - ENV: RUST_BACKTRACE is now full 03:31:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:31:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:31:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 03:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 03:31:01 INFO - Using env: {'DISPLAY': ':0', 03:31:01 INFO - 'HOME': '/home/cltbld', 03:31:01 INFO - 'LANG': 'en_US.UTF-8', 03:31:01 INFO - 'LANGUAGE': 'en_US:en', 03:31:01 INFO - 'LOGNAME': 'cltbld', 03:31:01 INFO - 'MAIL': '/var/mail/cltbld', 03:31:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:01 INFO - 'MOZ_NO_REMOTE': '1', 03:31:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:01 INFO - 'NO_EM_RESTART': '1', 03:31:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:01 INFO - 'PWD': '/builds/slave/test', 03:31:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:01 INFO - 'RUST_BACKTRACE': 'full', 03:31:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:31:01 INFO - 'SHELL': '/bin/bash', 03:31:01 INFO - 'SHLVL': '1', 03:31:01 INFO - 'TERM': 'linux', 03:31:01 INFO - 'TMOUT': '86400', 03:31:01 INFO - 'USER': 'cltbld', 03:31:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', 03:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:01 INFO - '_': '/tools/buildbot/bin/python'} 03:31:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 03:31:02 INFO - mozversion application_buildid: 20170919091230 03:31:02 INFO - mozversion application_changeset: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 03:31:02 INFO - mozversion application_display_name: Nightly 03:31:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:02 INFO - mozversion application_name: Firefox 03:31:02 INFO - mozversion application_remotingname: firefox 03:31:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:31:02 INFO - mozversion application_vendor: Mozilla 03:31:02 INFO - mozversion application_version: 57.0a1 03:31:02 INFO - mozversion platform_buildid: 20170919091230 03:31:02 INFO - mozversion platform_changeset: e4261f5b96ebfd63e7cb8af3035ff9fea90c74a5 03:31:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:31:02 INFO - mozversion platform_version: 57.0a1 03:31:02 INFO - using testdate: 1505817062 03:31:02 INFO - actual date: 1505817062 03:31:02 INFO - starting webserver on 'localhost:35625' 03:31:02 INFO - SUITE-START | Running 2 tests 03:31:02 INFO - TEST-START | dromaeo_css 03:31:02 INFO - Initialising browser for dromaeo_css test... 03:31:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35625/getInfo.html -profile /tmp/tmpC26RTn/profile 03:31:02 INFO - TEST-INFO | started process 7641 (/builds/slave/test/build/application/firefox/firefox http://localhost:35625/getInfo.html) 03:31:07 INFO - TEST-INFO | 7641: exit 0 03:31:07 INFO - Browser initialized. 03:31:07 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:07 INFO - Using env: {'DISPLAY': ':0', 03:31:07 INFO - 'HOME': '/home/cltbld', 03:31:07 INFO - 'JSGC_DISABLE_POISONING': '1', 03:31:07 INFO - 'LANG': 'en_US.UTF-8', 03:31:07 INFO - 'LANGUAGE': 'en_US:en', 03:31:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:31:07 INFO - 'LOGNAME': 'cltbld', 03:31:07 INFO - 'MAIL': '/var/mail/cltbld', 03:31:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:07 INFO - 'MOZ_CRASHREPORTER': '1', 03:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:31:07 INFO - 'MOZ_NO_REMOTE': '1', 03:31:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:07 INFO - 'NO_EM_RESTART': '1', 03:31:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:07 INFO - 'PWD': '/builds/slave/test', 03:31:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:07 INFO - 'RUST_BACKTRACE': 'full', 03:31:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:31:07 INFO - 'SHELL': '/bin/bash', 03:31:07 INFO - 'SHLVL': '1', 03:31:07 INFO - 'STYLO_FORCE_DISABLED': '1', 03:31:07 INFO - 'TERM': 'linux', 03:31:07 INFO - 'TMOUT': '86400', 03:31:07 INFO - 'USER': 'cltbld', 03:31:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', 03:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:07 INFO - '_': '/tools/buildbot/bin/python'} 03:31:07 INFO - TEST-INFO | started process 7877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC26RTn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:08 INFO - PID 7877 | 03:31:08 INFO - PID 7877 | (/builds/slave/test/build/application/firefox/firefox:7926): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:31:08 INFO - PID 7877 | 03:31:18 INFO - PID 7877 | RSS: Main: 147333120 03:31:18 INFO - PID 7877 | 03:34:16 INFO - PID 7877 | Cycle 1(1): loaded http://localhost:35625/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35625/tests/dromaeo/cssquery-ext.html) 03:34:17 INFO - PID 7877 | RSS: Main: 148000768 03:34:17 INFO - PID 7877 | 03:37:19 INFO - PID 7877 | Cycle 1(1): loaded http://localhost:35625/tests/dromaeo/cssquery-ext.html (next: http://localhost:35625/tests/dromaeo/cssquery-jquery.html) 03:37:19 INFO - PID 7877 | RSS: Main: 148017152 03:37:19 INFO - PID 7877 | 03:40:21 INFO - PID 7877 | Cycle 1(1): loaded http://localhost:35625/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35625/tests/dromaeo/cssquery-mootools.html) 03:40:21 INFO - PID 7877 | RSS: Main: 149524480 03:40:21 INFO - PID 7877 | 03:43:23 INFO - PID 7877 | Cycle 1(1): loaded http://localhost:35625/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35625/tests/dromaeo/cssquery-prototype.html) 03:43:23 INFO - PID 7877 | RSS: Main: 148254720 03:43:23 INFO - PID 7877 | 03:46:27 INFO - PID 7877 | Cycle 1(1): loaded http://localhost:35625/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35625/tests/dromaeo/cssquery-yui.html) 03:46:27 INFO - PID 7877 | RSS: Main: 149516288 03:46:27 INFO - PID 7877 | 03:49:29 INFO - PID 7877 | Cycle 1(1): loaded http://localhost:35625/tests/dromaeo/cssquery-yui.html (next: http://localhost:35625/tests/dromaeo/cssquery-dojo.html) 03:49:29 INFO - PID 7877 | RSS: Main: 152207360 03:49:29 INFO - PID 7877 | 03:49:29 INFO - PID 7877 | __start_tp_report 03:49:29 INFO - PID 7877 | _x_x_mozilla_page_load 03:49:29 INFO - PID 7877 | _x_x_mozilla_page_load_details 03:49:29 INFO - PID 7877 | |i|pagename|runs| 03:49:29 INFO - PID 7877 | |0;dojo.html;3872.4191371294287;3894.9415758763616;3914.2562913046536;3924.450576919231;3933.0560665440303;6230.376962303767;6316.431521163095;6327.050942358643;6375.075614035968;6444.323346048668;6271.059341098838;6300.275468321144;6324;6330.96834515828;6342.492600591953;5649.096144616862;5659.547236221113;5679.062954612495;5707.65754054756;5751.654900705971;5554.694491802949;5648.548116150719;5733.111367738007;5745.5690823188215;5766.942330576682;5628.212050312959;5705.343885453184;5724.370319264877;5742.28221472316;5765.250517432728;5557.805476808333;5633.549316054706;5641.294838145232;5659.5755318350875;5677.744501497401;5657.57568182388;5666.46168613981;5687.687177205252;5715.342735585377;5717.714114294268;6233.345498722614;6280.937190628081;6321.6523091229965;6365.61806291624;6389.393007664265;6769;6817.2443781836255;6869.7595584154315;6872.175338959307;6876.587404755731;6684.796736587412;6865.759698410531;6981;6981.965090174567;6991.580505169706;6290.654014029273;6323.14637523933;6352.269489008777;6365.713542890581;6372.044193371032;6986.336298051677;7066.3640272374705;7073.257307982691;7106.928930710626;7164.9641751790905;6742.595444273359;6750.7299708012115;6832.385085342343;6833.965830170818;6861.451083913275;6762.492813039042;6850.280720524373;6907.7236910524025;6914.204866440323;6948.895766563505;6810.795676129724;6811.352921472551;6820.6930688119155;6836.829079273058;6841.863162736718;6675.232348279913;6833.93166068333;6835.726570937107;6842.4183944364295;6847.760328388582;4932.728699921467;4975.502449754996;4990.051890140861;4991.80032798684;4995.425526064549;4478.977605111953;4510.458744950627;4515.254982927846;4520.660950428731;4521.434820647419;6176.227971503562;6183.319834818167;6318.684065796691;6370.58591191571;6405.807825765234;6798.082258894986;6808.11494505721;6812.386885180357;6814.1482314710665;6818.249992500821;6186.072089186658;6227.501799856001;6343.175387199634;6355.523335749837;6357.841053973688;5494.587905907073;5496.120620700669;5554.472325129106;5576.414476479992;5585.162225666182;7003.614801185881;7110.64446777659;7112.893306600405;7182.569045857265;7187;6797.28628494001;6866.759663411756;6869;6873.828154295982;6878.793636190722;7147.1780745214965;7196.172440169238;7235;7236.529625574321;7248.89126663111;6803.353681400259;6820.249772525118;6840.692168852314;6931.89602155958;6935.6878940446795;6824.658767061726;6880.967854821817;6910.516263861481;6999.825004374931;7007.509474336747;6540.920748076514;6543.574667646588;6606.4384527315715;6608.372204640552;6634.03806448072;6450.354964503512;6524.412802847766;6553.344665533408;6602.60384376939;6625.536212465081;6541.215054193527;6543.738250470118;6545;6551.312112228147;6552.63960482159;6496.252930913006;6568;6574.671266436755;6575.375339342946;6699.933000670126;6380.840478988062;6390.616563006234;6426.485881129592;6442.065900444316;6449.6130232186215 03:49:29 INFO - PID 7877 | |1;ext.html;954.3033585482598;956.3162338927665;988.7379844341249;1001.58934836717;1017.674344209853;45245.77377113114;45860.31209531851;46034.30948535775;46050;46059.07881842361;42791.14417711644;43258.351124733155;43291.567084329145;43615.78192109035;43624;7886.6845326186885;8013.599320034004;8018.518888866687;8037.075736290314;8040;7849.25432083954;7934.44458887878;7937.523748575075;7955.164707705694;7959.2836644701965;7933.206679332078;7944.523328600274;7951.483153595027;8401.789955251106;8579.785505362353;8502.404831661786;8525.74422767318;8546.487210767375;8562.957185214065;8564.3148548116;8073.555954422504;8118.878216826753;8174.3460523158;8195;8424.368172387096;41208;41729.79135104336;41790.37314440286;41793.79103104465;41815.372769408175;3730.0674831292176;3778.149916268845;3780.7164462665137;3783.5459744830523;3794.4308353746883;33377;33392.6660733392;33438;33513.32973340544;33673.32653346944;5487.945120548783;5498.1752737089355;5508.14623733322;5516.9448305516835;5530.087535556669;221724;222755;223527.8823605888;223943;224281.6357754635;51609.483905160465;51651.74174129181;51789;51855.740721296155;51985.48014519807;54180.72909635427;54305;54315.18527222095;54377.72811135919;54396.832300931346;16494.917525412537;16817.41139060127;16838.663226735396;16883.40908068212;16918.830811691972;13715;13729.725405491834;13730.244836534086;13795.724085518434;13842;14568.85431145675;14620.780688289684;14644.853551464348;14823.851761482247;14848.925755371154;5951;5988.790392336247;6044.093385992136;6112.449879510866;6183.598066125777;1073.3238060022136;1094.409019129677;1104.309806371018;1128.8588926384202;1138.3283862521153;25132.623010654854;25287.241382758548;25305.228633995812;25321.74678253194;25483.490330193665;1182.3851597169423;1212.2786941769632;1212.3271584270815;1212.3756265523264;1224.718314787586;13331.666708332175;13445.058845880694;13467.797983030263;13487.635668013534;13597.524086657117;272814;275402;275673;276047;276537;50331;51617.48382516202;57368.71315643395;59612.403875960685;60131.398686013454;1547.334646102187;1555.5566663500847;1565.3738504598025;1565.3816742386693;1566.6475043115436;30343.544846827757;30347.696523034487;30411.239719006317;30756.231094222825;30768.153910765424;41809;41932;42004;42040;42069.57930420656;242456;243637;243937;243951;243991;36178.27643447169;36339.45490817693;36366.45450318194;36418.8179059103;36541.81729091337;45911.3113303294;47168.292475613576;47883.28175077307;47902.760486197345;48307.5169248303;34226.97319080432;34540.65459345374;35322;35632.10919726924;35640.465393019644;35377.11557210988;35497.290054199286;35607.643923560434;35620;36051.098722532144;41793.16413671771;42226;42287.365689515296;42357.57642423536;42564.57435425606;34456;34482.137946551535;34623.65376346305;34746;35486.64513354937;25448.618270726325;25720.871395642902;25861.353466163495;26500.602490962265;26796 03:49:29 INFO - PID 7877 | |2;jquery.html;583.9211706419635;591.7130191856951;609.1137395090144;615.6244690738648;626.5050610018086;22918.312450626487;23419.76580234197;23519.94160262788;23520;23537.058517659294;24187.39531511713;26182.6072608911;26497.072602458917;26501.20496385107;26519;6722.663866806653;6776.830579235534;6817.897731534031;6825.078614387044;6865.5537390069485;6269.905951410709;6499.870002599969;6502.089707440939;6533.542652014361;6684.799456016327;6461.12774775404;6461.515386346019;6465.062565927938;6492.837679058038;6494;6366.808995730135;6388.680565971706;6452.483801295909;6694;6706.83232919176;6191.845203869894;6214.533909956726;6220.626762394271;6228.03465462854;6244.094606282064;31399;31965.680343196735;31981;32051;32190.19524511906;2289.4963108116353;2301.2635956493928;2311.3412677386864;2313.838031337807;2316.119874447699;19714;21073;21203.5759284815;21350.252741153985;21370.46573835651;2564.089748139421;2572.15119010726;2609.8825552850167;2618.2668852721076;2659.880305386262;124817.37591311986;130750;154272;157653;163207.1839640806;16078.919605401898;16273.674526509403;16401.917990409973;16635.91682041582;17262.82737172612;26429.47141057168;26479;26520.734792651827;26571.202863914114;26592.46815063688;10877.456127193609;10946.781064378667;10968.451577421098;10976.12191024716;11171.329720216812;9954.054364835329;9964.10323070927;10050.145737612238;10068.848967265498;10227.59089636421;9917.256205784595;10020.899791002143;10091.596336146618;10242.900205457863;10284.434356110485;2867.222322160232;2915.7375836174847;2936.1925470495785;2937.5740517625254;2968.4063187362613;1043.6295115234134;1050.3015494695942;1051.2063392138887;1051.9316244444087;1056.5562463765084;22227.44431389196;22333.330000100024;22540.549189016456;22565.88717056437;22881.656775148385;1103.9613613523488;1105.701460605632;1106.0709004436312;1108.8946550077892;1119.764849381639;12169.452374643162;12352.938235308946;12366.319852408204;12404.19372740769;12488.687782805502;597903;600503;607694;614309;648884;126656;131879;132027.33986330198;134979;136998;1194.6129532559937;1213.2538488829307;1231.5258625429274;1236.9010479161645;1242.099477878549;19435.416937491897;19519.219231230592;19634.705479418106;19654.312099076462;19858.60282794365;60873.69563152156;61045.69477152586;61117.08324375227;62012.68993655003;63051.684741576;78815;79039;79531.2046879547;79559;79909;15628.531144065697;16105.275262613444;16170.838291616934;16177;16194.352225911303;25078.74921250837;25577.616335755352;25958.87020564885;26005.089821856902;26009;20236.291729789977;20535.4866128348;20621.89689051545;20720.378388648365;20738.066786994925;16694.58263543421;16707.248173831962;17623.735643965094;18616.81383186151;18774.15516301797;20725.58548829045;20964.161433543097;21003.68494472615;21028.894855526236;21390.893045534674;15592.92203538975;15684;15694.9215253923;15814.367425302858;15876.761848572512;19930.60138797245;20247;20343.389698309074;20399.898000510497;20423.080961356478 03:49:29 INFO - PID 7877 | |3;mootools.html;1390.673191799927;1461.349699383774;1479.7114562660286;1488.836228014918;1502.0687173952151;17201.913990430046;17871.55321116973;17875.64248715025;17925.193366298514;17935.64128717428;17602.735958960628;17658.47024589261;17666.558336041573;17685.292588296452;17707.64584708305;2904.549794781812;2930.9706902930966;2950.2919299368214;2950.645922489304;2977.8064425812363;2801.32768135647;2832.6884042755282;2834.8157369770897;2839.1340641104457;2853.186841750102;2788.4004938938124;2789.288731373497;2795.9580606290924;2810.4098139390753;2830.1368082734757;2671.9846458345896;2755.1734479656025;2766.0457142285877;2767.7093905139873;2774.7225277472194;2413.843100198499;2492.3644470659865;2676.0633778177676;2721.18364490654;2816.507111255522;16223.51329460118;16360.263788129563;16378.099204543745;16383.09892955887;16385.59036024097;7894.289513943772;8137.511749295061;8163.510189388597;8164.346852251806;8167.877481837718;5718.857028574277;5834.57053022008;6076.605020673686;6084.60450070744;6104.481119104881;2141.914323427061;2180.095260466904;2187.2891310324208;2189.3650841256017;2216.8891555422324;29633.851830740707;30632;30678.693213067807;30721;30774;7435.665395057235;7519;7725.459217854696;7753.651085701157;7760.844783104306;19435.61128777445;19556.315528956417;19584.21663133487;19590.90204548968;19596.8040319595;8531.786705332417;8632.697855575025;8646.567671616394;8652.480851148952;8653.350998675125;7742.8838567421535;7968.880466793003;7983.361331093499;8003.279704826594;8012.599370031475;5520.779168833282;5633.69014704187;5677.432256774289;5700.37295897451;5951.940480595139;1645.1609679063763;1676.5808547863035;1682.8653707703354;1693.4073074423852;1701.077782106212;986.4229425785995;990.6879333010079;999;1015.081351377005;1017.3082304033328;8670.306375489945;8678.479291242546;8687.218150366498;8715.520646364384;8746.650133994695;785.1638005524098;803.7267329108131;803.9477433966773;805.4804651000189;807.184743409161;5605.215269862222;5998.280206375176;6042.848928776728;6143.508519318444;6166.537509686702;23224.41938951506;24416.267511974314;24496.755032449804;24721.381965451008;25271;23865.672014171443;24834.25497235086;24894.751052489606;24975;25155.24534263975;10373.273870828969;11554.364509951865;11765.588204412805;11902.345371004678;11953.342566158944;8789.384743067923;10150.612330448806;10183.541740621838;10263.640772572924;10320.845187322046;20551.177952881717;20653;21153.36539903805;21526.6770998432;21781.23765668194;21624.13503459907;21678.132874684838;21815.345539633836;21854.562908742053;22010.009549569986;11813.645590632295;11976.46105925218;11992.820107698217;12022.939885300517;12042.277463352228;14587.124772513684;14662.193579353238;14781.334839932013;14858;14999.32503037344;11828.40857957116;11846.229995050295;11967.940160299142;12090.576829810914;12176.269423834598;11636.709082272671;12020.75958480808;12207;12485.188462749893;12570.622881313575;10307.742306442098;10395.32430392022;10449;10459.581616735246;10478.895211047791;7813.202963318355;7999.240072193133;8055.7583272501915;8090.555019473985;8216.589170541569;8023.879641805261;8036.718714844952;8146.389020823581;8152.633131509215;8162.6734930602115 03:49:29 INFO - PID 7877 | |4;prototype.html;548.9505944464997;569.3480964295882;575.9798407055754;576.5186069631857;580.8170426315708;5669.461401166893;6076.392360763922;6236.812895613139;6342.270638876519;6406.615603063814;6225.875482490347;6244.687765611724;6254.593451425654;6260.217472815898;6267.780627678032;4939.654224204307;5017.824376146827;5029.823956161535;5031.094403007457;5041.72270525121;4941.678790878582;5020.924686129711;5021.397432308128;5054.41874184468;5065.645404821664;4989.700617962933;4997.550220480156;5012.323336349601;5016.49835016499;5025.673331233458;4948.703077815325;4987.127252730776;5013.899722005576;5014.5737612303;5017.49825017499;4586.082783443291;4586.7477288749105;4589.79345929434;4597.609203217697;4624.791884365178;6199.535034872402;6215.81352559424;6285.057241413779;6312.463440607554;6317.715702793385;5880.235569375954;5898.970505147447;5907.793227237026;5913.46778789911;5913.970430147821;6564.179477565304;6574.474042076622;6628.43658289046;6674.733010679615;6707.865842683168;4781.593564546983;5023.070731914608;5070.518300761421;5083.11045567028;5098.694078355311;6814.522983391164;6825.931740682579;6945.437276612773;6962.980735586674;7046.999999999949;5200.401953775364;5204.245384419314;5219.4780521947505;5221.373435187802;5228.111221092423;5270.604704647167;5288.762005709676;5298.364196296469;5314.28257185275;5344.637117535004;5891.410858914074;5906.704664766745;5915.112733089984;5928.8814223716145;5933.317668468095;6694.531382803254;6717.932820671828;6725.495587830932;6729.207378937784;6751.25736169021;1800.7478952946599;1807.3312874236353;1808;1810.3301778342097;1834.5688763140652;1240.598124119739;1288.239938436327;1302.5441095616459;1318.643966129159;1326.9137506062075;6093.26880774301;6134.435718891654;6162.599431036968;6178.814635560941;6214.067889816473;6714.630695311805;6837.863242735217;6839.213490448563;6848.657567121624;6888.448924086061;6205.968970155211;6238.65687387189;6289.0880822280515;6293.496520278367;6318.905216421757;3529.4705794130573;3537.938618414517;3575.713942884563;3583.7312201584987;3589.174489867345;6942.78501262277;6962.721491140399;7075.610841403669;7106.964465177641;7120.821979450555;6970.79087627372;7055;7066.470014748812;7076.646167691595;7086.822829429202;6907.6891539879825;7027.262137475696;7080.575165490087;7164.820879478055;7186.92813071873;6587.463826426764;6620.569662971891;6658.500612453989;6726.428253598499;6762.628055456997;6682.532222744556;6691.665416729047;6710.597364158166;6751.864962700817;6759.459243260626;6957.08680112973;7049.189343225595;7082.662721301855;7088.015355700412;7129.429645628441;5129.128048231884;5167.974160129175;5174.534291913746;5182.922256166236;5235.397929238186;6377.904331434939;6591.802245932629;6757.155355580552;6841.931580684329;6887.7244910203035;6537;6585.979173228157;6595.703193356215;6609.372109649576;6628.734850605922;6503;6528.281888992112;6556.114924485133;6605.174353205849;6631.502637302318;6368.395002474757;6455.354464553695;6478.125453063776;6491.415772580491;6571.638559879061;6589.7364105435245;6599.327272454663;6653.301403352578;6684.465242780663;6695.665216739046;6432.710528026344;6453.676996215859;6465.127207827071;6488.448481879093;6508.902366464412 03:49:29 INFO - PID 7877 | |5;yui.html;953.1612181280481;970.1075010989892;973.3429934794012;982.1062832822131;1020.1634659579144;16892.32430702772;17333.13334333283;17352.30590776369;17354.652906941854;17358.305667773304;17900.910495447537;17914;17937.820621793777;18125.909370453162;18800.24799008038;1020.9030142136485;1026.2303272545591;1038.086483894172;1038.4703801061476;1038.6416686243233;1059.3379138038727;1062.8299472084468;1064.787042591481;1065.1106326217619;1070.9625163119292;1071.0360675392171;1114.9052330551913;1127.2334812327615;1128.1257025805025;1128.3850301585655;1096.627146770094;1098.3300186885992;1102.9338239705603;1106.2366966792968;1106.535255192817;793.4802704228739;818.5457071325412;819.5656302159805;822.0258993093204;822.8601137806527;18702.906485467487;18863.056847157724;18956.905215473835;18980.240790368367;18988.575856810796;21163.153473861028;21182.258620948192;21285.68071478929;21469.785302146935;21491.892540537352;18174.363897263665;18503;18737.063146842604;18810.90594547032;18865.245390184376;3960.920781584352;3982.342913419311;3999.3001224785835;4004.2592120457807;4008.4388185654034;152773;153235;154065.22967385204;155066;156432;17676.381326653507;17891.1948962297;18099.095045247686;18111.18499667518;18231.72652410215;33347.166320842174;34221.65778342234;34328.82835585806;34352;34366.14084647904;8813.47119172839;9017.864732029026;9113.81772364549;9185.265178785681;9228.077192280718;4429.247028005247;4493.910121797546;4500.482444518922;4514.774261286922;4529.207388706963;6120.234970628671;6206.875862482815;6209.2548894133;6271.372862713783;6293.968530157412;1087.4508373271606;1107.5237647811518;1114.9832752508719;1118.0831717991332;1120.4453795371344;668.5687731413309;683.6205905722372;686.8083874477777;688.1948120698794;689.2211800665216;11404.144689148347;11561.364124973206;11819.468123934443;12731.681707957376;13387.464501420029;669.5079116849112;678.7793966960758;683.2859661653584;691;697.1494776372817;5867.70661466925;5925.05199168131;5975.970120149372;6006.159137720722;6064.9090263646085;141803.29098354443;144716;146610;147792.26103869412;150712;125491;127006;127058;129498.35250823686;132789.33605332105;108143;108246.45876770566;109323.99999999841;109889.35165972517;112077.43961280142;11341.09271258281;11390.54437822511;11448.885511145116;11503.424828758361;11613.419329033684;51283.23075153801;53468.73265633647;53539;53854.73072634612;54349.18476222781;65846.67076664585;67334;67877.66061169663;68019;68504.31495684979;14674.853251467348;14836.703265934837;14886.925565372103;14977.775333369791;15024;16529.834701652828;16546.42087526931;16603.66792664164;16634.50096497107;16877.831221688117;15320.616984575474;15385.846141538888;15421.074735515906;15452.072875627498;15518.84481155174;14933.925330373278;14947.626309342353;14970.476033339217;15029.398824046915;15052.3226454812;14959.102453852804;15183.696326073195;15220.847791521943;15292.847071529142;15397.615059623151;12167.513299467922;12350.938245308716;12451.315177665316;12496.812547811973;12556.497740090294;11796.52813887435;11806;11889.405529723306;11920.701982450508;12167.209131406431 03:49:29 INFO - PID 7877 | __end_tp_report 03:49:29 INFO - PID 7877 | __start_cc_report 03:49:29 INFO - PID 7877 | _x_x_mozilla_cycle_collect,256 03:49:29 INFO - PID 7877 | __end_cc_report 03:49:29 INFO - PID 7877 | __startTimestamp1505818169442__endTimestamp 03:49:29 INFO - PID 7877 | 03:49:29 INFO - PID 7877 | ------- Summary: start ------- 03:49:29 INFO - PID 7877 | Number of tests: 6 03:49:29 INFO - PID 7877 | 03:49:29 INFO - PID 7877 | [#0] dojo.html Cycles:165 Average:6298.70 Median:6524.41 stddev:755.58 (11.6%) stddev-sans-first:733.53 03:49:29 INFO - PID 7877 | Values: 3872.4 3894.9 3914.3 3924.5 3933.1 6230.4 6316.4 6327.1 6375.1 6444.3 6271.1 6300.3 6324.0 6331.0 6342.5 5649.1 5659.5 5679.1 5707.7 5751.7 5554.7 5648.5 5733.1 5745.6 5766.9 5628.2 5705.3 5724.4 5742.3 5765.3 5557.8 5633.5 5641.3 5659.6 5677.7 5657.6 5666.5 5687.7 5715.3 5717.7 6233.3 6280.9 6321.7 6365.6 6389.4 6769.0 6817.2 6869.8 6872.2 6876.6 6684.8 6865.8 6981.0 6982.0 6991.6 6290.7 6323.1 6352.3 6365.7 6372.0 6986.3 7066.4 7073.3 7106.9 7165.0 6742.6 6750.7 6832.4 6834.0 6861.5 6762.5 6850.3 6907.7 6914.2 6948.9 6810.8 6811.4 6820.7 6836.8 6841.9 6675.2 6833.9 6835.7 6842.4 6847.8 4932.7 4975.5 4990.1 4991.8 4995.4 4479.0 4510.5 4515.3 4520.7 4521.4 6176.2 6183.3 6318.7 6370.6 6405.8 6798.1 6808.1 6812.4 6814.1 6818.2 6186.1 6227.5 6343.2 6355.5 6357.8 5494.6 5496.1 5554.5 5576.4 5585.2 7003.6 7110.6 7112.9 7182.6 7187.0 6797.3 6866.8 6869.0 6873.8 6878.8 7147.2 7196.2 7235.0 7236.5 7248.9 6803.4 6820.2 6840.7 6931.9 6935.7 6824.7 6881.0 6910.5 6999.8 7007.5 6540.9 6543.6 6606.4 6608.4 6634.0 6450.4 6524.4 6553.3 6602.6 6625.5 6541.2 6543.7 6545.0 6551.3 6552.6 6496.3 6568.0 6574.7 6575.4 6699.9 6380.8 6390.6 6426.5 6442.1 6449.6 03:49:29 INFO - PID 7877 | 03:49:29 INFO - PID 7877 | [#1] ext.html Cycles:180 Average:42874.37 Median:36480.32 stddev:64461.67 (176.7%) stddev-sans-first:64565.65 03:49:29 INFO - PID 7877 | Values: 954.3 956.3 988.7 1001.6 1017.7 45245.8 45860.3 46034.3 46050.0 46059.1 42791.1 43258.4 43291.6 43615.8 43624.0 7886.7 8013.6 8018.5 8037.1 8040.0 7849.3 7934.4 7937.5 7955.2 7959.3 7933.2 7944.5 7951.5 8401.8 8579.8 8502.4 8525.7 8546.5 8563.0 8564.3 8073.6 8118.9 8174.3 8195.0 8424.4 41208.0 41729.8 41790.4 41793.8 41815.4 3730.1 3778.1 3780.7 3783.5 3794.4 33377.0 33392.7 33438.0 33513.3 33673.3 5487.9 5498.2 5508.1 5516.9 5530.1 221724.0 222755.0 223527.9 223943.0 224281.6 51609.5 51651.7 51789.0 51855.7 51985.5 54180.7 54305.0 54315.2 54377.7 54396.8 16494.9 16817.4 16838.7 16883.4 16918.8 13715.0 13729.7 13730.2 13795.7 13842.0 14568.9 14620.8 14644.9 14823.9 14848.9 5951.0 5988.8 6044.1 6112.4 6183.6 1073.3 1094.4 1104.3 1128.9 1138.3 25132.6 25287.2 25305.2 25321.7 25483.5 1182.4 1212.3 1212.3 1212.4 1224.7 13331.7 13445.1 13467.8 13487.6 13597.5 272814.0 275402.0 275673.0 276047.0 276537.0 50331.0 51617.5 57368.7 59612.4 60131.4 1547.3 1555.6 1565.4 1565.4 1566.6 30343.5 30347.7 30411.2 30756.2 30768.2 41809.0 41932.0 42004.0 42040.0 42069.6 242456.0 243637.0 243937.0 243951.0 243991.0 36178.3 36339.5 36366.5 36418.8 36541.8 45911.3 47168.3 47883.3 47902.8 48307.5 34227.0 34540.7 35322.0 35632.1 35640.5 35377.1 35497.3 35607.6 35620.0 36051.1 41793.2 42226.0 42287.4 42357.6 42564.6 34456.0 34482.1 34623.7 34746.0 35486.6 25448.6 25720.9 25861.4 26500.6 26796.0 03:49:29 INFO - PID 7877 | 03:49:29 INFO - PID 7877 | [#2] jquery.html Cycles:180 Average:40161.26 Median:22723.77 stddev:102534.45 (451.2%) stddev-sans-first:102779.03 03:49:29 INFO - PID 7877 | Values: 583.9 591.7 609.1 615.6 626.5 22918.3 23419.8 23519.9 23520.0 23537.1 24187.4 26182.6 26497.1 26501.2 26519.0 6722.7 6776.8 6817.9 6825.1 6865.6 6269.9 6499.9 6502.1 6533.5 6684.8 6461.1 6461.5 6465.1 6492.8 6494.0 6366.8 6388.7 6452.5 6694.0 6706.8 6191.8 6214.5 6220.6 6228.0 6244.1 31399.0 31965.7 31981.0 32051.0 32190.2 2289.5 2301.3 2311.3 2313.8 2316.1 19714.0 21073.0 21203.6 21350.3 21370.5 2564.1 2572.2 2609.9 2618.3 2659.9 124817.4 130750.0 154272.0 157653.0 163207.2 16078.9 16273.7 16401.9 16635.9 17262.8 26429.5 26479.0 26520.7 26571.2 26592.5 10877.5 10946.8 10968.5 10976.1 11171.3 9954.1 9964.1 10050.1 10068.8 10227.6 9917.3 10020.9 10091.6 10242.9 10284.4 2867.2 2915.7 2936.2 2937.6 2968.4 1043.6 1050.3 1051.2 1051.9 1056.6 22227.4 22333.3 22540.5 22565.9 22881.7 1104.0 1105.7 1106.1 1108.9 1119.8 12169.5 12352.9 12366.3 12404.2 12488.7 597903.0 600503.0 607694.0 614309.0 648884.0 126656.0 131879.0 132027.3 134979.0 136998.0 1194.6 1213.3 1231.5 1236.9 1242.1 19435.4 19519.2 19634.7 19654.3 19858.6 60873.7 61045.7 61117.1 62012.7 63051.7 78815.0 79039.0 79531.2 79559.0 79909.0 15628.5 16105.3 16170.8 16177.0 16194.4 25078.7 25577.6 25958.9 26005.1 26009.0 20236.3 20535.5 20621.9 20720.4 20738.1 16694.6 16707.2 17623.7 18616.8 18774.2 20725.6 20964.2 21003.7 21028.9 21390.9 15592.9 15684.0 15694.9 15814.4 15876.8 19930.6 20247.0 20343.4 20399.9 20423.1 03:49:29 INFO - PID 7877 | 03:49:29 INFO - PID 7877 | [#3] mootools.html Cycles:180 Average:10349.35 Median:25065.12 stddev:7656.44 (30.5%) stddev-sans-first:7648.33 03:49:29 INFO - PID 7877 | Values: 1390.7 1461.3 1479.7 1488.8 1502.1 17201.9 17871.6 17875.6 17925.2 17935.6 17602.7 17658.5 17666.6 17685.3 17707.6 2904.5 2931.0 2950.3 2950.6 2977.8 2801.3 2832.7 2834.8 2839.1 2853.2 2788.4 2789.3 2796.0 2810.4 2830.1 2672.0 2755.2 2766.0 2767.7 2774.7 2413.8 2492.4 2676.1 2721.2 2816.5 16223.5 16360.3 16378.1 16383.1 16385.6 7894.3 8137.5 8163.5 8164.3 8167.9 5718.9 5834.6 6076.6 6084.6 6104.5 2141.9 2180.1 2187.3 2189.4 2216.9 29633.9 30632.0 30678.7 30721.0 30774.0 7435.7 7519.0 7725.5 7753.7 7760.8 19435.6 19556.3 19584.2 19590.9 19596.8 8531.8 8632.7 8646.6 8652.5 8653.4 7742.9 7968.9 7983.4 8003.3 8012.6 5520.8 5633.7 5677.4 5700.4 5951.9 1645.2 1676.6 1682.9 1693.4 1701.1 986.4 990.7 999.0 1015.1 1017.3 8670.3 8678.5 8687.2 8715.5 8746.7 785.2 803.7 803.9 805.5 807.2 5605.2 5998.3 6042.8 6143.5 6166.5 23224.4 24416.3 24496.8 24721.4 25271.0 23865.7 24834.3 24894.8 24975.0 25155.2 10373.3 11554.4 11765.6 11902.3 11953.3 8789.4 10150.6 10183.5 10263.6 10320.8 20551.2 20653.0 21153.4 21526.7 21781.2 21624.1 21678.1 21815.3 21854.6 22010.0 11813.6 11976.5 11992.8 12022.9 12042.3 14587.1 14662.2 14781.3 14858.0 14999.3 11828.4 11846.2 11967.9 12090.6 12176.3 11636.7 12020.8 12207.0 12485.2 12570.6 10307.7 10395.3 10449.0 10459.6 10478.9 7813.2 7999.2 8055.8 8090.6 8216.6 8023.9 8036.7 8146.4 8152.6 8162.7 03:49:29 INFO - PID 7877 | 03:49:29 INFO - PID 7877 | [#4] prototype.html Cycles:180 Average:5656.70 Median:6264.00 stddev:1584.13 (25.3%) stddev-sans-first:1541.48 03:49:29 INFO - PID 7877 | Values: 549.0 569.3 576.0 576.5 580.8 5669.5 6076.4 6236.8 6342.3 6406.6 6225.9 6244.7 6254.6 6260.2 6267.8 4939.7 5017.8 5029.8 5031.1 5041.7 4941.7 5020.9 5021.4 5054.4 5065.6 4989.7 4997.6 5012.3 5016.5 5025.7 4948.7 4987.1 5013.9 5014.6 5017.5 4586.1 4586.7 4589.8 4597.6 4624.8 6199.5 6215.8 6285.1 6312.5 6317.7 5880.2 5899.0 5907.8 5913.5 5914.0 6564.2 6574.5 6628.4 6674.7 6707.9 4781.6 5023.1 5070.5 5083.1 5098.7 6814.5 6825.9 6945.4 6963.0 7047.0 5200.4 5204.2 5219.5 5221.4 5228.1 5270.6 5288.8 5298.4 5314.3 5344.6 5891.4 5906.7 5915.1 5928.9 5933.3 6694.5 6717.9 6725.5 6729.2 6751.3 1800.7 1807.3 1808.0 1810.3 1834.6 1240.6 1288.2 1302.5 1318.6 1326.9 6093.3 6134.4 6162.6 6178.8 6214.1 6714.6 6837.9 6839.2 6848.7 6888.4 6206.0 6238.7 6289.1 6293.5 6318.9 3529.5 3537.9 3575.7 3583.7 3589.2 6942.8 6962.7 7075.6 7107.0 7120.8 6970.8 7055.0 7066.5 7076.6 7086.8 6907.7 7027.3 7080.6 7164.8 7186.9 6587.5 6620.6 6658.5 6726.4 6762.6 6682.5 6691.7 6710.6 6751.9 6759.5 6957.1 7049.2 7082.7 7088.0 7129.4 5129.1 5168.0 5174.5 5182.9 5235.4 6377.9 6591.8 6757.2 6841.9 6887.7 6537.0 6586.0 6595.7 6609.4 6628.7 6503.0 6528.3 6556.1 6605.2 6631.5 6368.4 6455.4 6478.1 6491.4 6571.6 6589.7 6599.3 6653.3 6684.5 6695.7 6432.7 6453.7 6465.1 6488.4 6508.9 03:49:29 INFO - PID 7877 | 03:49:29 INFO - PID 7877 | [#5] yui.html Cycles:180 Average:26920.59 Median:16885.08 stddev:41032.39 (243.0%) stddev-sans-first:41101.17 03:49:29 INFO - PID 7877 | Values: 953.2 970.1 973.3 982.1 1020.2 16892.3 17333.1 17352.3 17354.7 17358.3 17900.9 17914.0 17937.8 18125.9 18800.2 1020.9 1026.2 1038.1 1038.5 1038.6 1059.3 1062.8 1064.8 1065.1 1071.0 1071.0 1114.9 1127.2 1128.1 1128.4 1096.6 1098.3 1102.9 1106.2 1106.5 793.5 818.5 819.6 822.0 822.9 18702.9 18863.1 18956.9 18980.2 18988.6 21163.2 21182.3 21285.7 21469.8 21491.9 18174.4 18503.0 18737.1 18810.9 18865.2 3960.9 3982.3 3999.3 4004.3 4008.4 152773.0 153235.0 154065.2 155066.0 156432.0 17676.4 17891.2 18099.1 18111.2 18231.7 33347.2 34221.7 34328.8 34352.0 34366.1 8813.5 9017.9 9113.8 9185.3 9228.1 4429.2 4493.9 4500.5 4514.8 4529.2 6120.2 6206.9 6209.3 6271.4 6294.0 1087.5 1107.5 1115.0 1118.1 1120.4 668.6 683.6 686.8 688.2 689.2 11404.1 11561.4 11819.5 12731.7 13387.5 669.5 678.8 683.3 691.0 697.1 5867.7 5925.1 5976.0 6006.2 6064.9 141803.3 144716.0 146610.0 147792.3 150712.0 125491.0 127006.0 127058.0 129498.4 132789.3 108143.0 108246.5 109324.0 109889.4 112077.4 11341.1 11390.5 11448.9 11503.4 11613.4 51283.2 53468.7 53539.0 53854.7 54349.2 65846.7 67334.0 67877.7 68019.0 68504.3 14674.9 14836.7 14886.9 14977.8 15024.0 16529.8 16546.4 16603.7 16634.5 16877.8 15320.6 15385.8 15421.1 15452.1 15518.8 14933.9 14947.6 14970.5 15029.4 15052.3 14959.1 15183.7 15220.8 15292.8 15397.6 12167.5 12350.9 12451.3 12496.8 12556.5 11796.5 11806.0 11889.4 11920.7 12167.2 03:49:29 INFO - PID 7877 | -------- Summary: end -------- 03:49:29 INFO - PID 7877 | 03:49:30 INFO - TEST-INFO | 7877: exit 0 03:49:30 INFO - TEST-OK | dromaeo_css | took 1108082ms 03:49:30 INFO - TEST-START | kraken 03:49:30 INFO - Initialising browser for kraken test... 03:49:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35625/getInfo.html -profile /tmp/tmpls1Qug/profile 03:49:30 INFO - TEST-INFO | started process 8248 (/builds/slave/test/build/application/firefox/firefox http://localhost:35625/getInfo.html) 03:49:35 INFO - TEST-INFO | 8248: exit 0 03:49:35 INFO - Browser initialized. 03:49:35 INFO - Running cycle 1/1 for kraken test... 03:49:35 INFO - Using env: {'DISPLAY': ':0', 03:49:35 INFO - 'HOME': '/home/cltbld', 03:49:35 INFO - 'JSGC_DISABLE_POISONING': '1', 03:49:35 INFO - 'LANG': 'en_US.UTF-8', 03:49:35 INFO - 'LANGUAGE': 'en_US:en', 03:49:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:49:35 INFO - 'LOGNAME': 'cltbld', 03:49:35 INFO - 'MAIL': '/var/mail/cltbld', 03:49:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:49:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:49:35 INFO - 'MOZ_CRASHREPORTER': '1', 03:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:49:35 INFO - 'MOZ_NO_REMOTE': '1', 03:49:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:35 INFO - 'NO_EM_RESTART': '1', 03:49:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:49:35 INFO - 'PWD': '/builds/slave/test', 03:49:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:49:35 INFO - 'RUST_BACKTRACE': 'full', 03:49:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:49:35 INFO - 'SHELL': '/bin/bash', 03:49:35 INFO - 'SHLVL': '1', 03:49:35 INFO - 'STYLO_FORCE_DISABLED': '1', 03:49:35 INFO - 'TERM': 'linux', 03:49:35 INFO - 'TMOUT': '86400', 03:49:35 INFO - 'USER': 'cltbld', 03:49:35 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658', 03:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:35 INFO - '_': '/tools/buildbot/bin/python'} 03:49:35 INFO - TEST-INFO | started process 8485 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpls1Qug/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:36 INFO - PID 8485 | 03:49:36 INFO - PID 8485 | (/builds/slave/test/build/application/firefox/firefox:8535): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:49:36 INFO - PID 8485 | 03:49:46 INFO - PID 8485 | RSS: Main: 146874368 03:49:46 INFO - PID 8485 | 03:49:49 INFO - PID 8485 | Cycle 1(1): loaded http://localhost:35625/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35625/tests/kraken/driver.html?testName=audio-beat-detection) 03:49:50 INFO - PID 8485 | RSS: Main: 152485888 03:49:50 INFO - PID 8485 | 03:49:52 INFO - PID 8485 | Cycle 1(1): loaded http://localhost:35625/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35625/tests/kraken/driver.html?testName=audio-dft) 03:49:53 INFO - PID 8485 | RSS: Main: 152743936 03:49:53 INFO - PID 8485 | 03:49:56 INFO - PID 8485 | Cycle 1(1): loaded http://localhost:35625/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35625/tests/kraken/driver.html?testName=audio-fft) 03:49:56 INFO - PID 8485 | RSS: Main: 149147648 03:49:56 INFO - PID 8485 | 03:49:58 INFO - PID 8485 | Cycle 1(1): loaded http://localhost:35625/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35625/tests/kraken/driver.html?testName=audio-oscillator) 03:49:59 INFO - PID 8485 | RSS: Main: 150335488 03:49:59 INFO - PID 8485 | 03:50:01 INFO - PID 8485 | Cycle 1(1): loaded http://localhost:35625/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35625/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:02 INFO - PID 8485 | RSS: Main: 149782528 03:50:02 INFO - PID 8485 | 03:50:05 INFO - PID 8485 | Cycle 1(1): loaded http://localhost:35625/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35625/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:05 INFO - PID 8485 | RSS: Main: 150077440 03:50:05 INFO - PID 8485 | 03:50:09 INFO - PID 8485 | Cycle 1(1): loaded http://localhost:35625/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35625/tests/kraken/driver.html?testName=imaging-desaturate) 03:50:10 INFO - PID 8485 | RSS: Main: 150958080 03:50:10 INFO - PID 8485 | 03:50:12 INFO - PID 8485 | Cycle 1(1): loaded http://localhost:35625/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35625/tests/kraken/driver.html?testName=json-parse-financial) 03:50:13 INFO - PID 8485 | RSS: Main: 152412160 03:50:13 INFO - PID 8485 | 03:50:14 INFO - PID 8485 | Cycle 1(1): loaded http://localhost:35625/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35625/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:50:15 INFO - PID 8485 | RSS: Main: 152821760 03:50:15 INFO - PID 8485 | 03:50:17 INFO - PID 8485 | Cycle 1(1): loaded http://localhost:35625/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35625/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:50:17 INFO - PID 8485 | RSS: Main: 152477696 03:50:17 INFO - PID 8485 | 03:50:19 INFO - PID 8485 | Cycle 1(1): loaded http://localhost:35625/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35625/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:50:20 INFO - PID 8485 | RSS: Main: 149540864 03:50:20 INFO - PID 8485 | 03:50:22 INFO - PID 8485 | Cycle 1(1): loaded http://localhost:35625/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:50:23 INFO - PID 8485 | RSS: Main: 149970944 03:50:23 INFO - PID 8485 | 03:50:26 INFO - PID 8485 | Cycle 1(1): loaded http://localhost:35625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:50:26 INFO - PID 8485 | RSS: Main: 150519808 03:50:26 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | Cycle 1(1): loaded http://localhost:35625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35625/tests/kraken/driver.html?testName=ai-astar) 03:50:28 INFO - PID 8485 | RSS: Main: 151916544 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | __start_tp_report 03:50:28 INFO - PID 8485 | _x_x_mozilla_page_load 03:50:28 INFO - PID 8485 | _x_x_mozilla_page_load_details 03:50:28 INFO - PID 8485 | |i|pagename|runs| 03:50:28 INFO - PID 8485 | |0;ai-astar;107;105;107;105;107;105;107;105;105;105 03:50:28 INFO - PID 8485 | |1;audio-beat-detection;114;113;111;111;118;120;114;115;117;118 03:50:28 INFO - PID 8485 | |2;audio-dft;163;166;162;161;161;160;161;162;166;166 03:50:28 INFO - PID 8485 | |3;audio-fft;78;73;78;78;73;74;74;73;73;74 03:50:28 INFO - PID 8485 | |4;audio-oscillator;78;78;78;78;78;78;80;78;78;78 03:50:28 INFO - PID 8485 | |5;imaging-gaussian-blur;113;114;113;114;114;113;114;114;110;114 03:50:28 INFO - PID 8485 | |6;imaging-darkroom;149;148;157;150;149;150;150;151;150;151 03:50:28 INFO - PID 8485 | |7;imaging-desaturate;94;94;94;95;95;94;94;94;95;94 03:50:28 INFO - PID 8485 | |8;json-parse-financial;43;44;43;43;47;43;43;46;44;44 03:50:28 INFO - PID 8485 | |9;json-stringify-tinderbox;37;37;37;41;38;37;37;37;37;37 03:50:28 INFO - PID 8485 | |10;stanford-crypto-aes;73;78;72;71;71;75;73;70;70;71 03:50:28 INFO - PID 8485 | |11;stanford-crypto-ccm;112;106;104;104;114;112;106;107;105;113 03:50:28 INFO - PID 8485 | |12;stanford-crypto-pbkdf2;149;152;154;150;149;146;149;166;162;154 03:50:28 INFO - PID 8485 | |13;stanford-crypto-sha256-iterative;60;60;66;61;60;59;58;59;64;58 03:50:28 INFO - PID 8485 | __end_tp_report 03:50:28 INFO - PID 8485 | __start_cc_report 03:50:28 INFO - PID 8485 | _x_x_mozilla_cycle_collect,707 03:50:28 INFO - PID 8485 | __end_cc_report 03:50:28 INFO - PID 8485 | __startTimestamp1505818228746__endTimestamp 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | ------- Summary: start ------- 03:50:28 INFO - PID 8485 | Number of tests: 14 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | [#0] ai-astar Cycles:10 Average:105.80 Median:106.00 stddev:1.03 (1.0%) stddev-sans-first:1.00 03:50:28 INFO - PID 8485 | Values: 107.0 105.0 107.0 105.0 107.0 105.0 107.0 105.0 105.0 105.0 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | [#1] audio-beat-detection Cycles:10 Average:115.10 Median:116.00 stddev:3.07 (2.6%) stddev-sans-first:3.23 03:50:28 INFO - PID 8485 | Values: 114.0 113.0 111.0 111.0 118.0 120.0 114.0 115.0 117.0 118.0 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.50 stddev:2.35 (1.4%) stddev-sans-first:2.49 03:50:28 INFO - PID 8485 | Values: 163.0 166.0 162.0 161.0 161.0 160.0 161.0 162.0 166.0 166.0 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | [#3] audio-fft Cycles:10 Average:74.80 Median:74.00 stddev:2.25 (3.0%) stddev-sans-first:2.07 03:50:28 INFO - PID 8485 | Values: 78.0 73.0 78.0 78.0 73.0 74.0 74.0 73.0 73.0 74.0 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:78.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 03:50:28 INFO - PID 8485 | Values: 78.0 78.0 78.0 78.0 78.0 78.0 80.0 78.0 78.0 78.0 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:114.00 stddev:1.25 (1.1%) stddev-sans-first:1.32 03:50:28 INFO - PID 8485 | Values: 113.0 114.0 113.0 114.0 114.0 113.0 114.0 114.0 110.0 114.0 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.00 stddev:2.46 (1.6%) stddev-sans-first:2.55 03:50:28 INFO - PID 8485 | Values: 149.0 148.0 157.0 150.0 149.0 150.0 150.0 151.0 150.0 151.0 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:50:28 INFO - PID 8485 | Values: 94.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | [#8] json-parse-financial Cycles:10 Average:44.00 Median:44.00 stddev:1.41 (3.2%) stddev-sans-first:1.45 03:50:28 INFO - PID 8485 | Values: 43.0 44.0 43.0 43.0 47.0 43.0 43.0 46.0 44.0 44.0 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | [#9] json-stringify-tinderbox Cycles:10 Average:37.50 Median:37.00 stddev:1.27 (3.4%) stddev-sans-first:1.33 03:50:28 INFO - PID 8485 | Values: 37.0 37.0 37.0 41.0 38.0 37.0 37.0 37.0 37.0 37.0 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:72.50 stddev:2.50 (3.5%) stddev-sans-first:2.65 03:50:28 INFO - PID 8485 | Values: 73.0 78.0 72.0 71.0 71.0 75.0 73.0 70.0 70.0 71.0 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | [#11] stanford-crypto-ccm Cycles:10 Average:108.30 Median:109.50 stddev:3.97 (3.6%) stddev-sans-first:3.98 03:50:28 INFO - PID 8485 | Values: 112.0 106.0 104.0 104.0 114.0 112.0 106.0 107.0 105.0 113.0 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:153.00 stddev:6.31 (4.1%) stddev-sans-first:6.52 03:50:28 INFO - PID 8485 | Values: 149.0 152.0 154.0 150.0 149.0 146.0 149.0 166.0 162.0 154.0 03:50:28 INFO - PID 8485 | 03:50:28 INFO - PID 8485 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:60.00 stddev:2.59 (4.3%) stddev-sans-first:2.74 03:50:28 INFO - PID 8485 | Values: 60.0 60.0 66.0 61.0 60.0 59.0 58.0 59.0 64.0 58.0 03:50:28 INFO - PID 8485 | -------- Summary: end -------- 03:50:28 INFO - PID 8485 | 03:50:29 INFO - PID 8485 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:50:29 INFO - TEST-INFO | 8485: exit 0 03:50:29 INFO - TEST-OK | kraken | took 59238ms 03:50:29 INFO - SUITE-END | took 1167s 03:50:29 INFO - Completed test suite (00:19:27) 03:50:29 INFO - javascript benchmark 03:50:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9020.209805290591, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3872.4191371294287, 3894.9415758763616, 3914.2562913046536, 3924.450576919231, 3933.0560665440303, 6230.376962303767, 6316.431521163095, 6327.050942358643, 6375.075614035968, 6444.323346048668, 6271.059341098838, 6300.275468321144, 6324.0, 6330.96834515828, 6342.492600591953, 5649.096144616862, 5659.547236221113, 5679.062954612495, 5707.65754054756, 5751.654900705971, 5554.694491802949, 5648.548116150719, 5733.111367738007, 5745.5690823188215, 5766.942330576682, 5628.212050312959, 5705.343885453184, 5724.370319264877, 5742.28221472316, 5765.250517432728, 5557.805476808333, 5633.549316054706, 5641.294838145232, 5659.5755318350875, 5677.744501497401, 5657.57568182388, 5666.46168613981, 5687.687177205252, 5715.342735585377, 5717.714114294268, 6233.345498722614, 6280.937190628081, 6321.6523091229965, 6365.61806291624, 6389.393007664265, 6769.0, 6817.2443781836255, 6869.7595584154315, 6872.175338959307, 6876.587404755731, 6684.796736587412, 6865.759698410531, 6981.0, 6981.965090174567, 6991.580505169706, 6290.654014029273, 6323.14637523933, 6352.269489008777, 6365.713542890581, 6372.044193371032, 6986.336298051677, 7066.3640272374705, 7073.257307982691, 7106.928930710626, 7164.9641751790905, 6742.595444273359, 6750.7299708012115, 6832.385085342343, 6833.965830170818, 6861.451083913275, 6762.492813039042, 6850.280720524373, 6907.7236910524025, 6914.204866440323, 6948.895766563505, 6810.795676129724, 6811.352921472551, 6820.6930688119155, 6836.829079273058, 6841.863162736718, 6675.232348279913, 6833.93166068333, 6835.726570937107, 6842.4183944364295, 6847.760328388582, 4932.728699921467, 4975.502449754996, 4990.051890140861, 4991.80032798684, 4995.425526064549, 4478.977605111953, 4510.458744950627, 4515.254982927846, 4520.660950428731, 4521.434820647419, 6176.227971503562, 6183.319834818167, 6318.684065796691, 6370.58591191571, 6405.807825765234, 6798.082258894986, 6808.11494505721, 6812.386885180357, 6814.1482314710665, 6818.249992500821, 6186.072089186658, 6227.501799856001, 6343.175387199634, 6355.523335749837, 6357.841053973688, 5494.587905907073, 5496.120620700669, 5554.472325129106, 5576.414476479992, 5585.162225666182, 7003.614801185881, 7110.64446777659, 7112.893306600405, 7182.569045857265, 7187.0, 6797.28628494001, 6866.759663411756, 6869.0, 6873.828154295982, 6878.793636190722, 7147.1780745214965, 7196.172440169238, 7235.0, 7236.529625574321, 7248.89126663111, 6803.353681400259, 6820.249772525118, 6840.692168852314, 6931.89602155958, 6935.6878940446795, 6824.658767061726, 6880.967854821817, 6910.516263861481, 6999.825004374931, 7007.509474336747, 6540.920748076514, 6543.574667646588, 6606.4384527315715, 6608.372204640552, 6634.03806448072, 6450.354964503512, 6524.412802847766, 6553.344665533408, 6602.60384376939, 6625.536212465081, 6541.215054193527, 6543.738250470118, 6545.0, 6551.312112228147, 6552.63960482159, 6496.252930913006, 6568.0, 6574.671266436755, 6575.375339342946, 6699.933000670126, 6380.840478988062, 6390.616563006234, 6426.485881129592, 6442.065900444316, 6449.6130232186215], "value": 6247.025392799453, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [954.3033585482598, 956.3162338927665, 988.7379844341249, 1001.58934836717, 1017.674344209853, 45245.77377113114, 45860.31209531851, 46034.30948535775, 46050.0, 46059.07881842361, 42791.14417711644, 43258.351124733155, 43291.567084329145, 43615.78192109035, 43624.0, 7886.6845326186885, 8013.599320034004, 8018.518888866687, 8037.075736290314, 8040.0, 7849.25432083954, 7934.44458887878, 7937.523748575075, 7955.164707705694, 7959.2836644701965, 7933.206679332078, 7944.523328600274, 7951.483153595027, 8401.789955251106, 8579.785505362353, 8502.404831661786, 8525.74422767318, 8546.487210767375, 8562.957185214065, 8564.3148548116, 8073.555954422504, 8118.878216826753, 8174.3460523158, 8195.0, 8424.368172387096, 41208.0, 41729.79135104336, 41790.37314440286, 41793.79103104465, 41815.372769408175, 3730.0674831292176, 3778.149916268845, 3780.7164462665137, 3783.5459744830523, 3794.4308353746883, 33377.0, 33392.6660733392, 33438.0, 33513.32973340544, 33673.32653346944, 5487.945120548783, 5498.1752737089355, 5508.14623733322, 5516.9448305516835, 5530.087535556669, 221724.0, 222755.0, 223527.8823605888, 223943.0, 224281.6357754635, 51609.483905160465, 51651.74174129181, 51789.0, 51855.740721296155, 51985.48014519807, 54180.72909635427, 54305.0, 54315.18527222095, 54377.72811135919, 54396.832300931346, 16494.917525412537, 16817.41139060127, 16838.663226735396, 16883.40908068212, 16918.830811691972, 13715.0, 13729.725405491834, 13730.244836534086, 13795.724085518434, 13842.0, 14568.85431145675, 14620.780688289684, 14644.853551464348, 14823.851761482247, 14848.925755371154, 5951.0, 5988.790392336247, 6044.093385992136, 6112.449879510866, 6183.598066125777, 1073.3238060022136, 1094.409019129677, 1104.309806371018, 1128.8588926384202, 1138.3283862521153, 25132.623010654854, 25287.241382758548, 25305.228633995812, 25321.74678253194, 25483.490330193665, 1182.3851597169423, 1212.2786941769632, 1212.3271584270815, 1212.3756265523264, 1224.718314787586, 13331.666708332175, 13445.058845880694, 13467.797983030263, 13487.635668013534, 13597.524086657117, 272814.0, 275402.0, 275673.0, 276047.0, 276537.0, 50331.0, 51617.48382516202, 57368.71315643395, 59612.403875960685, 60131.398686013454, 1547.334646102187, 1555.5566663500847, 1565.3738504598025, 1565.3816742386693, 1566.6475043115436, 30343.544846827757, 30347.696523034487, 30411.239719006317, 30756.231094222825, 30768.153910765424, 41809.0, 41932.0, 42004.0, 42040.0, 42069.57930420656, 242456.0, 243637.0, 243937.0, 243951.0, 243991.0, 36178.27643447169, 36339.45490817693, 36366.45450318194, 36418.8179059103, 36541.81729091337, 45911.3113303294, 47168.292475613576, 47883.28175077307, 47902.760486197345, 48307.5169248303, 34226.97319080432, 34540.65459345374, 35322.0, 35632.10919726924, 35640.465393019644, 35377.11557210988, 35497.290054199286, 35607.643923560434, 35620.0, 36051.098722532144, 41793.16413671771, 42226.0, 42287.365689515296, 42357.57642423536, 42564.57435425606, 34456.0, 34482.137946551535, 34623.65376346305, 34746.0, 35486.64513354937, 25448.618270726325, 25720.871395642902, 25861.353466163495, 26500.602490962265, 26796.0], "value": 18806.05205905019, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.9211706419635, 591.7130191856951, 609.1137395090144, 615.6244690738648, 626.5050610018086, 22918.312450626487, 23419.76580234197, 23519.94160262788, 23520.0, 23537.058517659294, 24187.39531511713, 26182.6072608911, 26497.072602458917, 26501.20496385107, 26519.0, 6722.663866806653, 6776.830579235534, 6817.897731534031, 6825.078614387044, 6865.5537390069485, 6269.905951410709, 6499.870002599969, 6502.089707440939, 6533.542652014361, 6684.799456016327, 6461.12774775404, 6461.515386346019, 6465.062565927938, 6492.837679058038, 6494.0, 6366.808995730135, 6388.680565971706, 6452.483801295909, 6694.0, 6706.83232919176, 6191.845203869894, 6214.533909956726, 6220.626762394271, 6228.03465462854, 6244.094606282064, 31399.0, 31965.680343196735, 31981.0, 32051.0, 32190.19524511906, 2289.4963108116353, 2301.2635956493928, 2311.3412677386864, 2313.838031337807, 2316.119874447699, 19714.0, 21073.0, 21203.5759284815, 21350.252741153985, 21370.46573835651, 2564.089748139421, 2572.15119010726, 2609.8825552850167, 2618.2668852721076, 2659.880305386262, 124817.37591311986, 130750.0, 154272.0, 157653.0, 163207.1839640806, 16078.919605401898, 16273.674526509403, 16401.917990409973, 16635.91682041582, 17262.82737172612, 26429.47141057168, 26479.0, 26520.734792651827, 26571.202863914114, 26592.46815063688, 10877.456127193609, 10946.781064378667, 10968.451577421098, 10976.12191024716, 11171.329720216812, 9954.054364835329, 9964.10323070927, 10050.145737612238, 10068.848967265498, 10227.59089636421, 9917.256205784595, 10020.899791002143, 10091.596336146618, 10242.900205457863, 10284.434356110485, 2867.222322160232, 2915.7375836174847, 2936.1925470495785, 2937.5740517625254, 2968.4063187362613, 1043.6295115234134, 1050.3015494695942, 1051.2063392138887, 1051.9316244444087, 1056.5562463765084, 22227.44431389196, 22333.330000100024, 22540.549189016456, 22565.88717056437, 22881.656775148385, 1103.9613613523488, 1105.701460605632, 1106.0709004436312, 1108.8946550077892, 1119.764849381639, 12169.452374643162, 12352.938235308946, 12366.319852408204, 12404.19372740769, 12488.687782805502, 597903.0, 600503.0, 607694.0, 614309.0, 648884.0, 126656.0, 131879.0, 132027.33986330198, 134979.0, 136998.0, 1194.6129532559937, 1213.2538488829307, 1231.5258625429274, 1236.9010479161645, 1242.099477878549, 19435.416937491897, 19519.219231230592, 19634.705479418106, 19654.312099076462, 19858.60282794365, 60873.69563152156, 61045.69477152586, 61117.08324375227, 62012.68993655003, 63051.684741576, 78815.0, 79039.0, 79531.2046879547, 79559.0, 79909.0, 15628.531144065697, 16105.275262613444, 16170.838291616934, 16177.0, 16194.352225911303, 25078.74921250837, 25577.616335755352, 25958.87020564885, 26005.089821856902, 26009.0, 20236.291729789977, 20535.4866128348, 20621.89689051545, 20720.378388648365, 20738.066786994925, 16694.58263543421, 16707.248173831962, 17623.735643965094, 18616.81383186151, 18774.15516301797, 20725.58548829045, 20964.161433543097, 21003.68494472615, 21028.894855526236, 21390.893045534674, 15592.92203538975, 15684.0, 15694.9215253923, 15814.367425302858, 15876.761848572512, 19930.60138797245, 20247.0, 20343.389698309074, 20399.898000510497, 20423.080961356478], "value": 12957.396281803141, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.673191799927, 1461.349699383774, 1479.7114562660286, 1488.836228014918, 1502.0687173952151, 17201.913990430046, 17871.55321116973, 17875.64248715025, 17925.193366298514, 17935.64128717428, 17602.735958960628, 17658.47024589261, 17666.558336041573, 17685.292588296452, 17707.64584708305, 2904.549794781812, 2930.9706902930966, 2950.2919299368214, 2950.645922489304, 2977.8064425812363, 2801.32768135647, 2832.6884042755282, 2834.8157369770897, 2839.1340641104457, 2853.186841750102, 2788.4004938938124, 2789.288731373497, 2795.9580606290924, 2810.4098139390753, 2830.1368082734757, 2671.9846458345896, 2755.1734479656025, 2766.0457142285877, 2767.7093905139873, 2774.7225277472194, 2413.843100198499, 2492.3644470659865, 2676.0633778177676, 2721.18364490654, 2816.507111255522, 16223.51329460118, 16360.263788129563, 16378.099204543745, 16383.09892955887, 16385.59036024097, 7894.289513943772, 8137.511749295061, 8163.510189388597, 8164.346852251806, 8167.877481837718, 5718.857028574277, 5834.57053022008, 6076.605020673686, 6084.60450070744, 6104.481119104881, 2141.914323427061, 2180.095260466904, 2187.2891310324208, 2189.3650841256017, 2216.8891555422324, 29633.851830740707, 30632.0, 30678.693213067807, 30721.0, 30774.0, 7435.665395057235, 7519.0, 7725.459217854696, 7753.651085701157, 7760.844783104306, 19435.61128777445, 19556.315528956417, 19584.21663133487, 19590.90204548968, 19596.8040319595, 8531.786705332417, 8632.697855575025, 8646.567671616394, 8652.480851148952, 8653.350998675125, 7742.8838567421535, 7968.880466793003, 7983.361331093499, 8003.279704826594, 8012.599370031475, 5520.779168833282, 5633.69014704187, 5677.432256774289, 5700.37295897451, 5951.940480595139, 1645.1609679063763, 1676.5808547863035, 1682.8653707703354, 1693.4073074423852, 1701.077782106212, 986.4229425785995, 990.6879333010079, 999.0, 1015.081351377005, 1017.3082304033328, 8670.306375489945, 8678.479291242546, 8687.218150366498, 8715.520646364384, 8746.650133994695, 785.1638005524098, 803.7267329108131, 803.9477433966773, 805.4804651000189, 807.184743409161, 5605.215269862222, 5998.280206375176, 6042.848928776728, 6143.508519318444, 6166.537509686702, 23224.41938951506, 24416.267511974314, 24496.755032449804, 24721.381965451008, 25271.0, 23865.672014171443, 24834.25497235086, 24894.751052489606, 24975.0, 25155.24534263975, 10373.273870828969, 11554.364509951865, 11765.588204412805, 11902.345371004678, 11953.342566158944, 8789.384743067923, 10150.612330448806, 10183.541740621838, 10263.640772572924, 10320.845187322046, 20551.177952881717, 20653.0, 21153.36539903805, 21526.6770998432, 21781.23765668194, 21624.13503459907, 21678.132874684838, 21815.345539633836, 21854.562908742053, 22010.009549569986, 11813.645590632295, 11976.46105925218, 11992.820107698217, 12022.939885300517, 12042.277463352228, 14587.124772513684, 14662.193579353238, 14781.334839932013, 14858.0, 14999.32503037344, 11828.40857957116, 11846.229995050295, 11967.940160299142, 12090.576829810914, 12176.269423834598, 11636.709082272671, 12020.75958480808, 12207.0, 12485.188462749893, 12570.622881313575, 10307.742306442098, 10395.32430392022, 10449.0, 10459.581616735246, 10478.895211047791, 7813.202963318355, 7999.240072193133, 8055.7583272501915, 8090.555019473985, 8216.589170541569, 8023.879641805261, 8036.718714844952, 8146.389020823581, 8152.633131509215, 8162.6734930602115], "value": 7248.9258178199125, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.9505944464997, 569.3480964295882, 575.9798407055754, 576.5186069631857, 580.8170426315708, 5669.461401166893, 6076.392360763922, 6236.812895613139, 6342.270638876519, 6406.615603063814, 6225.875482490347, 6244.687765611724, 6254.593451425654, 6260.217472815898, 6267.780627678032, 4939.654224204307, 5017.824376146827, 5029.823956161535, 5031.094403007457, 5041.72270525121, 4941.678790878582, 5020.924686129711, 5021.397432308128, 5054.41874184468, 5065.645404821664, 4989.700617962933, 4997.550220480156, 5012.323336349601, 5016.49835016499, 5025.673331233458, 4948.703077815325, 4987.127252730776, 5013.899722005576, 5014.5737612303, 5017.49825017499, 4586.082783443291, 4586.7477288749105, 4589.79345929434, 4597.609203217697, 4624.791884365178, 6199.535034872402, 6215.81352559424, 6285.057241413779, 6312.463440607554, 6317.715702793385, 5880.235569375954, 5898.970505147447, 5907.793227237026, 5913.46778789911, 5913.970430147821, 6564.179477565304, 6574.474042076622, 6628.43658289046, 6674.733010679615, 6707.865842683168, 4781.593564546983, 5023.070731914608, 5070.518300761421, 5083.11045567028, 5098.694078355311, 6814.522983391164, 6825.931740682579, 6945.437276612773, 6962.980735586674, 7046.999999999949, 5200.401953775364, 5204.245384419314, 5219.4780521947505, 5221.373435187802, 5228.111221092423, 5270.604704647167, 5288.762005709676, 5298.364196296469, 5314.28257185275, 5344.637117535004, 5891.410858914074, 5906.704664766745, 5915.112733089984, 5928.8814223716145, 5933.317668468095, 6694.531382803254, 6717.932820671828, 6725.495587830932, 6729.207378937784, 6751.25736169021, 1800.7478952946599, 1807.3312874236353, 1808.0, 1810.3301778342097, 1834.5688763140652, 1240.598124119739, 1288.239938436327, 1302.5441095616459, 1318.643966129159, 1326.9137506062075, 6093.26880774301, 6134.435718891654, 6162.599431036968, 6178.814635560941, 6214.067889816473, 6714.630695311805, 6837.863242735217, 6839.213490448563, 6848.657567121624, 6888.448924086061, 6205.968970155211, 6238.65687387189, 6289.0880822280515, 6293.496520278367, 6318.905216421757, 3529.4705794130573, 3537.938618414517, 3575.713942884563, 3583.7312201584987, 3589.174489867345, 6942.78501262277, 6962.721491140399, 7075.610841403669, 7106.964465177641, 7120.821979450555, 6970.79087627372, 7055.0, 7066.470014748812, 7076.646167691595, 7086.822829429202, 6907.6891539879825, 7027.262137475696, 7080.575165490087, 7164.820879478055, 7186.92813071873, 6587.463826426764, 6620.569662971891, 6658.500612453989, 6726.428253598499, 6762.628055456997, 6682.532222744556, 6691.665416729047, 6710.597364158166, 6751.864962700817, 6759.459243260626, 6957.08680112973, 7049.189343225595, 7082.662721301855, 7088.015355700412, 7129.429645628441, 5129.128048231884, 5167.974160129175, 5174.534291913746, 5182.922256166236, 5235.397929238186, 6377.904331434939, 6591.802245932629, 6757.155355580552, 6841.931580684329, 6887.7244910203035, 6537.0, 6585.979173228157, 6595.703193356215, 6609.372109649576, 6628.734850605922, 6503.0, 6528.281888992112, 6556.114924485133, 6605.174353205849, 6631.502637302318, 6368.395002474757, 6455.354464553695, 6478.125453063776, 6491.415772580491, 6571.638559879061, 6589.7364105435245, 6599.327272454663, 6653.301403352578, 6684.465242780663, 6695.665216739046, 6432.710528026344, 6453.676996215859, 6465.127207827071, 6488.448481879093, 6508.902366464412], "value": 5202.425835408904, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [953.1612181280481, 970.1075010989892, 973.3429934794012, 982.1062832822131, 1020.1634659579144, 16892.32430702772, 17333.13334333283, 17352.30590776369, 17354.652906941854, 17358.305667773304, 17900.910495447537, 17914.0, 17937.820621793777, 18125.909370453162, 18800.24799008038, 1020.9030142136485, 1026.2303272545591, 1038.086483894172, 1038.4703801061476, 1038.6416686243233, 1059.3379138038727, 1062.8299472084468, 1064.787042591481, 1065.1106326217619, 1070.9625163119292, 1071.0360675392171, 1114.9052330551913, 1127.2334812327615, 1128.1257025805025, 1128.3850301585655, 1096.627146770094, 1098.3300186885992, 1102.9338239705603, 1106.2366966792968, 1106.535255192817, 793.4802704228739, 818.5457071325412, 819.5656302159805, 822.0258993093204, 822.8601137806527, 18702.906485467487, 18863.056847157724, 18956.905215473835, 18980.240790368367, 18988.575856810796, 21163.153473861028, 21182.258620948192, 21285.68071478929, 21469.785302146935, 21491.892540537352, 18174.363897263665, 18503.0, 18737.063146842604, 18810.90594547032, 18865.245390184376, 3960.920781584352, 3982.342913419311, 3999.3001224785835, 4004.2592120457807, 4008.4388185654034, 152773.0, 153235.0, 154065.22967385204, 155066.0, 156432.0, 17676.381326653507, 17891.1948962297, 18099.095045247686, 18111.18499667518, 18231.72652410215, 33347.166320842174, 34221.65778342234, 34328.82835585806, 34352.0, 34366.14084647904, 8813.47119172839, 9017.864732029026, 9113.81772364549, 9185.265178785681, 9228.077192280718, 4429.247028005247, 4493.910121797546, 4500.482444518922, 4514.774261286922, 4529.207388706963, 6120.234970628671, 6206.875862482815, 6209.2548894133, 6271.372862713783, 6293.968530157412, 1087.4508373271606, 1107.5237647811518, 1114.9832752508719, 1118.0831717991332, 1120.4453795371344, 668.5687731413309, 683.6205905722372, 686.8083874477777, 688.1948120698794, 689.2211800665216, 11404.144689148347, 11561.364124973206, 11819.468123934443, 12731.681707957376, 13387.464501420029, 669.5079116849112, 678.7793966960758, 683.2859661653584, 691.0, 697.1494776372817, 5867.70661466925, 5925.05199168131, 5975.970120149372, 6006.159137720722, 6064.9090263646085, 141803.29098354443, 144716.0, 146610.0, 147792.26103869412, 150712.0, 125491.0, 127006.0, 127058.0, 129498.35250823686, 132789.33605332105, 108143.0, 108246.45876770566, 109323.99999999841, 109889.35165972517, 112077.43961280142, 11341.09271258281, 11390.54437822511, 11448.885511145116, 11503.424828758361, 11613.419329033684, 51283.23075153801, 53468.73265633647, 53539.0, 53854.73072634612, 54349.18476222781, 65846.67076664585, 67334.0, 67877.66061169663, 68019.0, 68504.31495684979, 14674.853251467348, 14836.703265934837, 14886.925565372103, 14977.775333369791, 15024.0, 16529.834701652828, 16546.42087526931, 16603.66792664164, 16634.50096497107, 16877.831221688117, 15320.616984575474, 15385.846141538888, 15421.074735515906, 15452.072875627498, 15518.84481155174, 14933.925330373278, 14947.626309342353, 14970.476033339217, 15029.398824046915, 15052.3226454812, 14959.102453852804, 15183.696326073195, 15220.847791521943, 15292.847071529142, 15397.615059623151, 12167.513299467922, 12350.938245308716, 12451.315177665316, 12496.812547811973, 12556.497740090294, 11796.52813887435, 11806.0, 11889.405529723306, 11920.701982450508, 12167.209131406431], "value": 9382.200540028598, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1370.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 107.0, 105.0, 107.0, 105.0, 107.0, 105.0, 105.0, 105.0], "value": 105.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 111.0, 111.0, 118.0, 120.0, 114.0, 115.0, 117.0, 118.0], "value": 115.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 162.0, 161.0, 161.0, 160.0, 161.0, 162.0, 166.0, 166.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 78.0, 78.0, 73.0, 74.0, 74.0, 73.0, 73.0, 74.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 78.0, 78.0, 80.0, 78.0, 78.0, 78.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 110.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 157.0, 150.0, 149.0, 150.0, 150.0, 151.0, 150.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 44.0, 43.0, 43.0, 47.0, 43.0, 43.0, 46.0, 44.0, 44.0], "value": 44.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 41.0, 38.0, 37.0, 37.0, 37.0, 37.0, 37.0], "value": 37.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 72.0, 71.0, 71.0, 75.0, 73.0, 70.0, 70.0, 71.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 104.0, 104.0, 114.0, 112.0, 106.0, 107.0, 105.0, 113.0], "value": 108.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 154.0, 150.0, 149.0, 146.0, 149.0, 166.0, 162.0, 154.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 66.0, 61.0, 60.0, 59.0, 58.0, 59.0, 64.0, 58.0], "value": 60.5, "unit": "score"}]}]} 03:50:29 INFO - Return code: 0 03:50:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:50:30 INFO - # TBPL SUCCESS # 03:50:30 INFO - Running post-action listener: _package_coverage_data 03:50:30 INFO - Running post-action listener: _resource_record_post_action 03:50:30 INFO - [mozharness: 2017-09-19 10:50:30.029216Z] Finished run-tests step (success) 03:50:30 INFO - Running post-run listener: _resource_record_post_run 03:50:30 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 28672; Write bytes: 454541312; Read time: 376; Write time: 344376 03:50:30 INFO - TinderboxPrint: CPU usage
13.1% 03:50:30 INFO - TinderboxPrint: I/O read bytes / time
28,672 / 376 03:50:30 INFO - TinderboxPrint: I/O write bytes / time
454,541,312 / 344,376 03:50:30 INFO - TinderboxPrint: CPU idle
8,220.2 (86.9%) 03:50:30 INFO - TinderboxPrint: CPU user
1,187.2 (12.6%) 03:50:30 INFO - TinderboxPrint: Swap in / out
0 / 0 03:50:30 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 20480; Write bytes: 133644288; Read time: 196; Write time: 140560 03:50:30 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:50:30 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 8192; Write bytes: 320446464; Read time: 180; Write time: 203792 03:50:30 INFO - Running post-run listener: _upload_blobber_files 03:50:30 INFO - Blob upload gear active. 03:50:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:50:30 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 03:50:30 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'] 03:50:30 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 03:50:31 INFO - (blobuploader) - INFO - Open directory for files ... 03:50:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:50:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:50:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:32 INFO - (blobuploader) - INFO - Done attempting. 03:50:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:50:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:50:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:33 INFO - (blobuploader) - INFO - Done attempting. 03:50:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:50:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:50:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:39 INFO - (blobuploader) - INFO - Done attempting. 03:50:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:50:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:50:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:40 INFO - (blobuploader) - INFO - Done attempting. 03:50:40 INFO - (blobuploader) - INFO - Iteration through files over. 03:50:40 INFO - Return code: 0 03:50:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:50:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:50:40 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3152b992181443279468d7f61090da839272d572f73a2503c2ef0bbd922c76e8972f4a82809ae15648db0e59caef02ec459102e89656263089ca78338da8263", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20f836a45d23e9311e21a5ebdcda1a562e4854a7a887079a85be07435ac49add694865c9de5d89e7717d40c4b19017d331e4a04c78ed203329b9ce520302e855", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/554a99be0b04694d16f056cb9135d74719a727505a0394d649941a9700b65f53dfbe6098d322ea9801c86bb726894f4b115b4e2a0a57a61f60383fea638e696b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b30ab01c853e996595b1c592bbb34f1a68860dd344800966bd4ecd728573c2da7ab32bd56af9d59fa34edd4638d3575197dfa88af04969a1d1a437f8930a3959"} 03:50:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:50:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:50:40 INFO - Contents: 03:50:40 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3152b992181443279468d7f61090da839272d572f73a2503c2ef0bbd922c76e8972f4a82809ae15648db0e59caef02ec459102e89656263089ca78338da8263", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20f836a45d23e9311e21a5ebdcda1a562e4854a7a887079a85be07435ac49add694865c9de5d89e7717d40c4b19017d331e4a04c78ed203329b9ce520302e855", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/554a99be0b04694d16f056cb9135d74719a727505a0394d649941a9700b65f53dfbe6098d322ea9801c86bb726894f4b115b4e2a0a57a61f60383fea638e696b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b30ab01c853e996595b1c592bbb34f1a68860dd344800966bd4ecd728573c2da7ab32bd56af9d59fa34edd4638d3575197dfa88af04969a1d1a437f8930a3959"} 03:50:40 INFO - Running post-run listener: copy_logs_to_upload_dir 03:50:40 INFO - Copying logs to upload dir... 03:50:40 INFO - mkdir: /builds/slave/test/build/upload/logs 03:50:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.510549 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-19 03:50:40.891315) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 03:50:40.894556) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3152b992181443279468d7f61090da839272d572f73a2503c2ef0bbd922c76e8972f4a82809ae15648db0e59caef02ec459102e89656263089ca78338da8263", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20f836a45d23e9311e21a5ebdcda1a562e4854a7a887079a85be07435ac49add694865c9de5d89e7717d40c4b19017d331e4a04c78ed203329b9ce520302e855", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/554a99be0b04694d16f056cb9135d74719a727505a0394d649941a9700b65f53dfbe6098d322ea9801c86bb726894f4b115b4e2a0a57a61f60383fea638e696b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b30ab01c853e996595b1c592bbb34f1a68860dd344800966bd4ecd728573c2da7ab32bd56af9d59fa34edd4638d3575197dfa88af04969a1d1a437f8930a3959"} build_url:https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/Y9n31viyR8mh7pkqvQO0YA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3152b992181443279468d7f61090da839272d572f73a2503c2ef0bbd922c76e8972f4a82809ae15648db0e59caef02ec459102e89656263089ca78338da8263", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20f836a45d23e9311e21a5ebdcda1a562e4854a7a887079a85be07435ac49add694865c9de5d89e7717d40c4b19017d331e4a04c78ed203329b9ce520302e855", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/554a99be0b04694d16f056cb9135d74719a727505a0394d649941a9700b65f53dfbe6098d322ea9801c86bb726894f4b115b4e2a0a57a61f60383fea638e696b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b30ab01c853e996595b1c592bbb34f1a68860dd344800966bd4ecd728573c2da7ab32bd56af9d59fa34edd4638d3575197dfa88af04969a1d1a437f8930a3959"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 03:50:40.923467) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:50:40.923816) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1505816953.612633-624775658 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:50:41.007237) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 03:50:41.007573) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 03:50:41.007893) ========= ========= Total master_lag: 0.20 =========