builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1505343358.97 results: success (0) revision: 0e706b53052c86b247bb8037d1a3fbf2e913045e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 15:55:58.972850) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 15:55:58.973265) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 15:55:58.973530) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 15:55:58.990768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:55:58.991044) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 15:55:59-- 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% 53.9M=0s 2017-09-13 15:55:59 (53.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128054 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:55:59.135561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:55:59.135864) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015107 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:55:59.184738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:55:59.185045) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0e706b53052c86b247bb8037d1a3fbf2e913045e --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 0e706b53052c86b247bb8037d1a3fbf2e913045e --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=516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 15:55:59,259 truncating revision to first 12 chars 2017-09-13 15:55:59,259 Setting DEBUG logging. 2017-09-13 15:55:59,259 attempt 1/10 2017-09-13 15:55:59,259 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0e706b53052c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 15:55:59,520 unpacking tar archive at: mozilla-central-0e706b53052c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529943 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 15:55:59.730930) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 15:55:59.731271) ========= script_repo_revision: 0e706b53052c86b247bb8037d1a3fbf2e913045e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 15:55:59.731626) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 15:55:59.731881) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 15:55:59.744993) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-13 15:55:59.745286) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:55:59 INFO - MultiFileLogger online at 20170913 15:55:59 in /builds/slave/test 15:55:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:55:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:55:59 INFO - {'append_to_log': False, 15:55:59 INFO - 'base_work_dir': '/builds/slave/test', 15:55:59 INFO - 'blob_upload_branch': 'Firefox', 15:55:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:55:59 INFO - 'branch': 'Firefox', 15:55:59 INFO - 'buildbot_json_path': 'buildprops.json', 15:55:59 INFO - 'code_coverage': False, 15:55:59 INFO - 'config_files': ('talos/linux_config.py',), 15:55:59 INFO - 'default_actions': ('clobber', 15:55:59 INFO - 'read-buildbot-config', 15:55:59 INFO - 'download-and-extract', 15:55:59 INFO - 'populate-webroot', 15:55:59 INFO - 'create-virtualenv', 15:55:59 INFO - 'install', 15:55:59 INFO - 'setup-mitmproxy', 15:55:59 INFO - 'run-tests'), 15:55:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:55:59 INFO - 'disable_ccov_upload': False, 15:55:59 INFO - 'disable_stylo': False, 15:55:59 INFO - 'download_minidump_stackwalk': True, 15:55:59 INFO - 'download_symbols': 'ondemand', 15:55:59 INFO - 'enable_stylo': False, 15:55:59 INFO - 'enable_webrender': False, 15:55:59 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:55:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:55:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:55:59 INFO - 'gecko_profile': False, 15:55:59 INFO - 'gecko_profile_interval': 0, 15:55:59 INFO - 'installer_path': 'installer.exe', 15:55:59 INFO - 'log_level': 'info', 15:55:59 INFO - 'log_name': 'talos', 15:55:59 INFO - 'log_to_console': True, 15:55:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:55:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:55:59 INFO - 'opt_config_files': (), 15:55:59 INFO - 'pip_index': False, 15:55:59 INFO - 'suite': 'dromaeojs-e10s', 15:55:59 INFO - 'system_bits': '32', 15:55:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:55:59 INFO - 'title': 'talos-linux64-ix-061', 15:55:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:55:59 INFO - 'use_talos_json': True, 15:55:59 INFO - 'verify': 'False', 15:55:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:55:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:55:59 INFO - 'work_dir': 'build'} 15:55:59 INFO - [mozharness: 2017-09-13 22:55:59.961876Z] Running clobber step. 15:55:59 INFO - Running pre-action listener: _resource_record_pre_action 15:55:59 INFO - Running main action method: clobber 15:55:59 INFO - rmtree: /builds/slave/test/build 15:55:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:56:00 INFO - Running post-action listener: _resource_record_post_action 15:56:00 INFO - [mozharness: 2017-09-13 22:56:00.959584Z] Finished clobber step (success) 15:56:00 INFO - [mozharness: 2017-09-13 22:56:00.959680Z] Running read-buildbot-config step. 15:56:00 INFO - Running pre-action listener: _resource_record_pre_action 15:56:00 INFO - Running main action method: read_buildbot_config 15:56:00 INFO - Using buildbot properties: 15:56:00 INFO - { 15:56:00 INFO - "project": "", 15:56:00 INFO - "product": "firefox", 15:56:00 INFO - "who": "kwierso@gmail.com", 15:56:00 INFO - "installer_path": "public/build/target.tar.bz2", 15:56:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:56:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:56:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 15:56:00 INFO - "stage_platform": "linux64-pgo", 15:56:00 INFO - "basedir": "/builds/slave/test", 15:56:00 INFO - "buildnumber": 181, 15:56:00 INFO - "platform": "ubuntu64_hw", 15:56:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:56:00 INFO - "slavebuilddir": "test", 15:56:00 INFO - "taskId": "B-1CFNuiRPyuBhXP-nzeQw", 15:56:00 INFO - "branch": "mozilla-central", 15:56:00 INFO - "script_repo_revision": "production", 15:56:00 INFO - "revision": "0e706b53052c86b247bb8037d1a3fbf2e913045e", 15:56:00 INFO - "slavename": "talos-linux64-ix-061", 15:56:00 INFO - "repo_path": "mozilla-central" 15:56:00 INFO - } 15:56:00 INFO - Finding installer, test and symbols from parent task. 15:56:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B-1CFNuiRPyuBhXP-nzeQw'}, attempt #1 15:56:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B-1CFNuiRPyuBhXP-nzeQw'}, attempt #1 15:56:01 INFO - Task dependencies: QM8-JeQ6TpyhR0ExuuU8YA 15:56:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA'}, attempt #1 15:56:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.tar.bz2 15:56:02 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.test_packages.json 15:56:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.crashreporter-symbols.zip 15:56:02 INFO - Running post-action listener: _resource_record_post_action 15:56:02 INFO - [mozharness: 2017-09-13 22:56:02.352751Z] Finished read-buildbot-config step (success) 15:56:02 INFO - [mozharness: 2017-09-13 22:56:02.353000Z] Running download-and-extract step. 15:56:02 INFO - Running pre-action listener: _resource_record_pre_action 15:56:02 INFO - Running main action method: download_and_extract 15:56:02 INFO - mkdir: /builds/slave/test/build/tests 15:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:02 INFO - trying https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.test_packages.json 15:56:02 INFO - Downloading https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:56:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:56:02 INFO - Downloaded 989 bytes. 15:56:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:56:02 INFO - Using the following test package requirements: 15:56:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:56:02 INFO - u'common': [u'target.common.tests.zip'], 15:56:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:56:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:56:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:56:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:56:02 INFO - u'mozbase': [u'target.common.tests.zip'], 15:56:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:56:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:56:02 INFO - u'web-platform': [u'target.common.tests.zip', 15:56:02 INFO - u'target.web-platform.tests.tar.gz'], 15:56:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:56:02 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:56:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.common.tests.zip 15:56:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:56:02 INFO - Fetch https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.common.tests.zip into memory 15:56:03 INFO - Content-Length response header: 55169679 15:56:03 INFO - Bytes received: 55169679 15:56:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.talos.tests.zip 15:56:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:56:14 INFO - Fetch https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.talos.tests.zip into memory 15:56:15 INFO - Content-Length response header: 14499226 15:56:15 INFO - Bytes received: 14499226 15:56:15 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')]} 15:56:15 INFO - trying https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.tar.bz2 15:56:15 INFO - Downloading https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:56:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:56:16 INFO - Downloaded 62029198 bytes. 15:56:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.tar.bz2 15:56:16 INFO - mkdir: /builds/slave/test/properties 15:56:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:56:16 INFO - Writing to file /builds/slave/test/properties/build_url 15:56:16 INFO - Contents: 15:56:16 INFO - build_url:https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.tar.bz2 15:56:16 INFO - Running post-action listener: _resource_record_post_action 15:56:16 INFO - Running post-action listener: find_tests_for_verification 15:56:16 INFO - Running post-action listener: set_extra_try_arguments 15:56:16 INFO - [mozharness: 2017-09-13 22:56:16.885081Z] Finished download-and-extract step (success) 15:56:16 INFO - [mozharness: 2017-09-13 22:56:16.885177Z] Running populate-webroot step. 15:56:16 INFO - Running pre-action listener: _resource_record_pre_action 15:56:16 INFO - Running main action method: populate_webroot 15:56:16 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:56:16 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['tresize', 15:56:16 INFO - 'tcanvasmark']}, 15:56:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:56:16 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['dromaeo_css', 15:56:16 INFO - 'kraken']}, 15:56:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:16 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'tests': ['damp', 'tps']}, 15:56:16 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['damp', 'tps']}, 15:56:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:56:16 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['dromaeo_dom']}, 15:56:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:56:16 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['basic_compositor_video', 15:56:16 INFO - 'glvideo']}, 15:56:16 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:56:16 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['ts_paint_webext', 15:56:16 INFO - 'tp5o_webext']}, 15:56:16 INFO - 'other-e10s': {'tests': ['a11yr', 15:56:16 INFO - 'ts_paint', 15:56:16 INFO - 'tpaint', 15:56:16 INFO - 'sessionrestore', 15:56:16 INFO - 'sessionrestore_many_windows', 15:56:16 INFO - 'sessionrestore_no_auto_restore', 15:56:16 INFO - 'tabpaint']}, 15:56:16 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['a11yr', 15:56:16 INFO - 'ts_paint', 15:56:16 INFO - 'tpaint', 15:56:16 INFO - 'sessionrestore', 15:56:16 INFO - 'sessionrestore_many_windows', 15:56:16 INFO - 'sessionrestore_no_auto_restore', 15:56:16 INFO - 'tabpaint']}, 15:56:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:56:16 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:56:16 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['bloom_basic_singleton']}, 15:56:16 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['bloom_basic']}, 15:56:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:56:16 INFO - 'tsvgr_opacity', 15:56:16 INFO - 'tart', 15:56:16 INFO - 'tscrollx', 15:56:16 INFO - 'tsvg_static']}, 15:56:16 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['tsvgx', 15:56:16 INFO - 'tsvgr_opacity', 15:56:16 INFO - 'tart', 15:56:16 INFO - 'tscrollx', 15:56:16 INFO - 'tsvg_static']}, 15:56:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:56:16 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['tp5o']}, 15:56:16 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:56:16 INFO - 'talos_options': ['--mitmproxy', 15:56:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:56:16 INFO - '--firstNonBlankPaint'], 15:56:16 INFO - 'tests': ['tp6_google', 15:56:16 INFO - 'tp6_youtube', 15:56:16 INFO - 'tp6_amazon', 15:56:16 INFO - 'tp6_facebook']}, 15:56:16 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:56:16 INFO - 'talos_options': ['--disable-stylo', 15:56:16 INFO - '--mitmproxy', 15:56:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:56:16 INFO - '--firstNonBlankPaint'], 15:56:16 INFO - 'tests': ['tp6_google', 15:56:16 INFO - 'tp6_youtube', 15:56:16 INFO - 'tp6_amazon', 15:56:16 INFO - 'tp6_facebook']}, 15:56:16 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:56:16 INFO - 'talos_options': ['--stylo-threads=1', 15:56:16 INFO - '--mitmproxy', 15:56:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:56:16 INFO - '--firstNonBlankPaint'], 15:56:16 INFO - 'tests': ['tp6_google', 15:56:16 INFO - 'tp6_youtube', 15:56:16 INFO - 'tp6_amazon', 15:56:16 INFO - 'tp6_facebook']}, 15:56:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'talos_options': ['--xperf_path', 15:56:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:16 INFO - 'tests': ['tp5n']}, 15:56:16 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'talos_options': ['--disable-stylo', 15:56:16 INFO - '--xperf_path', 15:56:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:16 INFO - 'tests': ['tp5n']}}} 15:56:16 INFO - Running post-action listener: _resource_record_post_action 15:56:16 INFO - [mozharness: 2017-09-13 22:56:16.900057Z] Finished populate-webroot step (success) 15:56:16 INFO - [mozharness: 2017-09-13 22:56:16.900145Z] Running create-virtualenv step. 15:56:16 INFO - Running pre-action listener: _resource_record_pre_action 15:56:16 INFO - Running main action method: create_virtualenv 15:56:16 INFO - Creating virtualenv /builds/slave/test/build/venv 15:56:16 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:56:16 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:56:16 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:56:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:56:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:56:17 INFO - Installing distribute.............................................................................................................................................................................................done. 15:56:17 INFO - Installing pip...............done. 15:56:17 INFO - Return code: 0 15:56:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:56:17 INFO - Reading from file tmpfile_stdout 15:56:17 INFO - Output received: 15:56:17 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:56:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:17 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 0x21491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2312a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9090>, '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 0x24b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b3f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', '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 15:56:17 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 15:56:17 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 15:56:17 INFO - Using env: {'DISPLAY': ':0', 15:56:17 INFO - 'HOME': '/home/cltbld', 15:56:17 INFO - 'LANG': 'en_US.UTF-8', 15:56:17 INFO - 'LANGUAGE': 'en_US:en', 15:56:17 INFO - 'LOGNAME': 'cltbld', 15:56:17 INFO - 'MAIL': '/var/mail/cltbld', 15:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:17 INFO - 'MOZ_NO_REMOTE': '1', 15:56:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:17 INFO - 'NO_EM_RESTART': '1', 15:56:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:17 INFO - 'PWD': '/builds/slave/test', 15:56:17 INFO - 'SHELL': '/bin/bash', 15:56:17 INFO - 'SHLVL': '1', 15:56:17 INFO - 'TERM': 'linux', 15:56:17 INFO - 'TMOUT': '86400', 15:56:17 INFO - 'USER': 'cltbld', 15:56:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', 15:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:17 INFO - '_': '/tools/buildbot/bin/python'} 15:56:19 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:56:19 INFO - Downloading/unpacking pip>=1.5 15:56:19 INFO - Running setup.py egg_info for package pip 15:56:19 INFO - warning: no files found matching 'pip/cacert.pem' 15:56:19 INFO - warning: no files found matching '*.html' under directory 'docs' 15:56:19 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:56:19 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:56:19 INFO - Installing collected packages: pip 15:56:19 INFO - Found existing installation: pip 1.1 15:56:19 INFO - Uninstalling pip: 15:56:19 INFO - Successfully uninstalled pip 15:56:19 INFO - Running setup.py install for pip 15:56:19 INFO - warning: no files found matching 'pip/cacert.pem' 15:56:19 INFO - warning: no files found matching '*.html' under directory 'docs' 15:56:19 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:56:19 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:56:19 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:56:19 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:56:19 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:56:19 INFO - Successfully installed pip 15:56:19 INFO - Cleaning up... 15:56:19 INFO - Return code: 0 15:56:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:19 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 0x21491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2312a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9090>, '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 0x24b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b3f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', '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 15:56:19 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 15:56:19 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 15:56:19 INFO - Using env: {'DISPLAY': ':0', 15:56:19 INFO - 'HOME': '/home/cltbld', 15:56:19 INFO - 'LANG': 'en_US.UTF-8', 15:56:19 INFO - 'LANGUAGE': 'en_US:en', 15:56:19 INFO - 'LOGNAME': 'cltbld', 15:56:19 INFO - 'MAIL': '/var/mail/cltbld', 15:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:19 INFO - 'MOZ_NO_REMOTE': '1', 15:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:19 INFO - 'NO_EM_RESTART': '1', 15:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:19 INFO - 'PWD': '/builds/slave/test', 15:56:19 INFO - 'SHELL': '/bin/bash', 15:56:19 INFO - 'SHLVL': '1', 15:56:19 INFO - 'TERM': 'linux', 15:56:19 INFO - 'TMOUT': '86400', 15:56:19 INFO - 'USER': 'cltbld', 15:56:19 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', 15:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:19 INFO - '_': '/tools/buildbot/bin/python'} 15:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:19 INFO - Downloading/unpacking psutil>=3.1.1 15:56:19 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 15:56:19 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 15:56:19 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 15:56:19 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 15:56:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:56:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:20 INFO - Installing collected packages: psutil 15:56:20 INFO - Running setup.py install for psutil 15:56:20 INFO - building 'psutil._psutil_linux' extension 15:56:20 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 15:56:20 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 15:56:20 INFO - building 'psutil._psutil_posix' extension 15:56:20 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 15:56:20 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 15:56:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:20 INFO - Successfully installed psutil 15:56:20 INFO - Cleaning up... 15:56:21 INFO - Return code: 0 15:56:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:56: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')]} 15:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56: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')]} 15:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:21 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 0x21491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2312a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9090>, '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 0x24b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b3f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', '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 15:56:21 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 15:56:21 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 15:56:21 INFO - Using env: {'DISPLAY': ':0', 15:56:21 INFO - 'HOME': '/home/cltbld', 15:56:21 INFO - 'LANG': 'en_US.UTF-8', 15:56:21 INFO - 'LANGUAGE': 'en_US:en', 15:56:21 INFO - 'LOGNAME': 'cltbld', 15:56:21 INFO - 'MAIL': '/var/mail/cltbld', 15:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:21 INFO - 'MOZ_NO_REMOTE': '1', 15:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:21 INFO - 'NO_EM_RESTART': '1', 15:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:21 INFO - 'PWD': '/builds/slave/test', 15:56:21 INFO - 'SHELL': '/bin/bash', 15:56:21 INFO - 'SHLVL': '1', 15:56:21 INFO - 'TERM': 'linux', 15:56:21 INFO - 'TMOUT': '86400', 15:56:21 INFO - 'USER': 'cltbld', 15:56:21 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', 15:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:21 INFO - '_': '/tools/buildbot/bin/python'} 15:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:56:21 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 15:56:21 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 15:56:21 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 15:56:21 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 15:56:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:56:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:56:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:56:22 INFO - Installing collected packages: mozsystemmonitor 15:56:22 INFO - Running setup.py install for mozsystemmonitor 15:56:22 INFO - Successfully installed mozsystemmonitor 15:56:22 INFO - Cleaning up... 15:56:23 INFO - Return code: 0 15:56:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:56:23 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')]} 15:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:23 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')]} 15:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:23 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 0x21491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2312a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9090>, '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 0x24b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b3f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', '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 15:56:23 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 15:56:23 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 15:56:23 INFO - Using env: {'DISPLAY': ':0', 15:56:23 INFO - 'HOME': '/home/cltbld', 15:56:23 INFO - 'LANG': 'en_US.UTF-8', 15:56:23 INFO - 'LANGUAGE': 'en_US:en', 15:56:23 INFO - 'LOGNAME': 'cltbld', 15:56:23 INFO - 'MAIL': '/var/mail/cltbld', 15:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:23 INFO - 'MOZ_NO_REMOTE': '1', 15:56:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:23 INFO - 'NO_EM_RESTART': '1', 15:56:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:23 INFO - 'PWD': '/builds/slave/test', 15:56:23 INFO - 'SHELL': '/bin/bash', 15:56:23 INFO - 'SHLVL': '1', 15:56:23 INFO - 'TERM': 'linux', 15:56:23 INFO - 'TMOUT': '86400', 15:56:23 INFO - 'USER': 'cltbld', 15:56:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', 15:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:23 INFO - '_': '/tools/buildbot/bin/python'} 15:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:23 INFO - Downloading/unpacking jsonschema==2.5.1 15:56:23 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 15:56:23 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 15:56:23 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 15:56:23 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 15:56:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:56:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:56:24 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 15:56:24 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 15:56:24 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 15:56:24 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 15:56:24 INFO - Downloading functools32-3.2.3-2.tar.gz 15:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:56:24 INFO - warning: no files found matching '*.txt' 15:56:24 INFO - no previously-included directories found matching 'build' 15:56:24 INFO - no previously-included directories found matching 'dist' 15:56:24 INFO - no previously-included directories found matching '.git*' 15:56:24 INFO - Installing collected packages: jsonschema, functools32 15:56:24 INFO - Running setup.py install for functools32 15:56:25 INFO - warning: no files found matching '*.txt' 15:56:25 INFO - no previously-included directories found matching 'build' 15:56:25 INFO - no previously-included directories found matching 'dist' 15:56:25 INFO - no previously-included directories found matching '.git*' 15:56:25 INFO - Successfully installed jsonschema functools32 15:56:25 INFO - Cleaning up... 15:56:25 INFO - Return code: 0 15:56:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:56: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')]} 15:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56: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')]} 15:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56: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', '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 0x21491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2312a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9090>, '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 0x24b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b3f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', '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 15:56: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:56: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 functools32==3.2.3-2 15:56:25 INFO - Using env: {'DISPLAY': ':0', 15:56:25 INFO - 'HOME': '/home/cltbld', 15:56:25 INFO - 'LANG': 'en_US.UTF-8', 15:56:25 INFO - 'LANGUAGE': 'en_US:en', 15:56:25 INFO - 'LOGNAME': 'cltbld', 15:56:25 INFO - 'MAIL': '/var/mail/cltbld', 15:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:25 INFO - 'MOZ_NO_REMOTE': '1', 15:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:25 INFO - 'NO_EM_RESTART': '1', 15:56:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:25 INFO - 'PWD': '/builds/slave/test', 15:56:25 INFO - 'SHELL': '/bin/bash', 15:56:25 INFO - 'SHLVL': '1', 15:56:25 INFO - 'TERM': 'linux', 15:56:25 INFO - 'TMOUT': '86400', 15:56:25 INFO - 'USER': 'cltbld', 15:56:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', 15:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:25 INFO - '_': '/tools/buildbot/bin/python'} 15:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:56:25 INFO - Cleaning up... 15:56:25 INFO - Return code: 0 15:56:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:56: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')]} 15:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56: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')]} 15:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56: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', '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 0x21491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2312a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9090>, '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 0x24b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b3f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', '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 15:56: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:56: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 blobuploader==1.2.4 15:56:25 INFO - Using env: {'DISPLAY': ':0', 15:56:25 INFO - 'HOME': '/home/cltbld', 15:56:25 INFO - 'LANG': 'en_US.UTF-8', 15:56:25 INFO - 'LANGUAGE': 'en_US:en', 15:56:25 INFO - 'LOGNAME': 'cltbld', 15:56:25 INFO - 'MAIL': '/var/mail/cltbld', 15:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:25 INFO - 'MOZ_NO_REMOTE': '1', 15:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:25 INFO - 'NO_EM_RESTART': '1', 15:56:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:25 INFO - 'PWD': '/builds/slave/test', 15:56:25 INFO - 'SHELL': '/bin/bash', 15:56:25 INFO - 'SHLVL': '1', 15:56:25 INFO - 'TERM': 'linux', 15:56:25 INFO - 'TMOUT': '86400', 15:56:25 INFO - 'USER': 'cltbld', 15:56:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', 15:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:25 INFO - '_': '/tools/buildbot/bin/python'} 15:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:25 INFO - Downloading/unpacking blobuploader==1.2.4 15:56:25 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 15:56:25 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 15:56:25 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 15:56:25 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 15:56:26 INFO - Downloading blobuploader-1.2.4.tar.gz 15:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:56:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:56:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:27 INFO - Downloading docopt-0.6.1.tar.gz 15:56:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:56:27 INFO - Installing collected packages: blobuploader, requests, docopt 15:56:27 INFO - Running setup.py install for blobuploader 15:56:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:56:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:56:27 INFO - Running setup.py install for requests 15:56:27 INFO - Running setup.py install for docopt 15:56:27 INFO - Successfully installed blobuploader requests docopt 15:56:27 INFO - Cleaning up... 15:56:27 INFO - Return code: 0 15:56:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:27 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')]} 15:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:27 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')]} 15:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:27 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 0x21491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2312a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9090>, '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 0x24b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b3f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', '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 15:56:27 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 15:56:27 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 15:56:27 INFO - Using env: {'DISPLAY': ':0', 15:56:27 INFO - 'HOME': '/home/cltbld', 15:56:27 INFO - 'LANG': 'en_US.UTF-8', 15:56:27 INFO - 'LANGUAGE': 'en_US:en', 15:56:27 INFO - 'LOGNAME': 'cltbld', 15:56:27 INFO - 'MAIL': '/var/mail/cltbld', 15:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:27 INFO - 'MOZ_NO_REMOTE': '1', 15:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:27 INFO - 'NO_EM_RESTART': '1', 15:56:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:27 INFO - 'PWD': '/builds/slave/test', 15:56:27 INFO - 'SHELL': '/bin/bash', 15:56:27 INFO - 'SHLVL': '1', 15:56:27 INFO - 'TERM': 'linux', 15:56:27 INFO - 'TMOUT': '86400', 15:56:27 INFO - 'USER': 'cltbld', 15:56:27 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', 15:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:27 INFO - '_': '/tools/buildbot/bin/python'} 15:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:56:27 INFO - Running setup.py (path:/tmp/pip-c6Anix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:56:28 INFO - Running setup.py (path:/tmp/pip-p0Vt92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:56:28 INFO - Running setup.py (path:/tmp/pip-RGPqFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:56:28 INFO - Running setup.py (path:/tmp/pip-DYQXXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:56:28 INFO - Running setup.py (path:/tmp/pip-36Q_ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:56:28 INFO - Running setup.py (path:/tmp/pip-y_jL_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:56:28 INFO - Running setup.py (path:/tmp/pip-gNdKlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:56:28 INFO - Running setup.py (path:/tmp/pip-b0CYGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:56:28 INFO - Running setup.py (path:/tmp/pip-3F7VBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:56:28 INFO - Running setup.py (path:/tmp/pip-zJkDRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:56:28 INFO - Running setup.py (path:/tmp/pip-_oAizv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:56:28 INFO - Running setup.py (path:/tmp/pip-zOzljA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:56:28 INFO - Running setup.py (path:/tmp/pip-FDtttn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:56:28 INFO - Running setup.py (path:/tmp/pip-8_BRt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:28 INFO - Running setup.py (path:/tmp/pip-GazgVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:56:29 INFO - Running setup.py (path:/tmp/pip-rGtR5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:56:29 INFO - Running setup.py (path:/tmp/pip-h_KSVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:56:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:56:29 INFO - Running setup.py install for manifestparser 15:56:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Running setup.py install for mozcrash 15:56:29 INFO - Running setup.py install for mozdebug 15:56:29 INFO - Running setup.py install for mozdevice 15:56:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Running setup.py install for mozfile 15:56:29 INFO - Running setup.py install for mozhttpd 15:56:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Running setup.py install for mozinfo 15:56:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Running setup.py install for mozInstall 15:56:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Running setup.py install for mozleak 15:56:30 INFO - Running setup.py install for mozlog 15:56:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:56:30 INFO - Running setup.py install for moznetwork 15:56:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:56:30 INFO - Running setup.py install for mozprocess 15:56:30 INFO - Running setup.py install for mozprofile 15:56:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:56:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:56:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:56:30 INFO - Running setup.py install for mozrunner 15:56:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:56:30 INFO - Running setup.py install for mozscreenshot 15:56:30 INFO - Running setup.py install for moztest 15:56:30 INFO - Running setup.py install for mozversion 15:56:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:56:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:56:30 INFO - Cleaning up... 15:56:30 INFO - Return code: 0 15:56:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56: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')]} 15:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56: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')]} 15:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:30 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 0x21491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2312a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9090>, '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 0x24b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b3f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', '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 15:56:30 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 15:56:30 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 15:56:30 INFO - Using env: {'DISPLAY': ':0', 15:56:30 INFO - 'HOME': '/home/cltbld', 15:56:30 INFO - 'LANG': 'en_US.UTF-8', 15:56:30 INFO - 'LANGUAGE': 'en_US:en', 15:56:30 INFO - 'LOGNAME': 'cltbld', 15:56:30 INFO - 'MAIL': '/var/mail/cltbld', 15:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:30 INFO - 'MOZ_NO_REMOTE': '1', 15:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:30 INFO - 'NO_EM_RESTART': '1', 15:56:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:30 INFO - 'PWD': '/builds/slave/test', 15:56:30 INFO - 'SHELL': '/bin/bash', 15:56:30 INFO - 'SHLVL': '1', 15:56:30 INFO - 'TERM': 'linux', 15:56:30 INFO - 'TMOUT': '86400', 15:56:30 INFO - 'USER': 'cltbld', 15:56:30 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', 15:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:30 INFO - '_': '/tools/buildbot/bin/python'} 15:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:56:31 INFO - Running setup.py (path:/tmp/pip-ol7zz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:56:31 INFO - Running setup.py (path:/tmp/pip-QY7VrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:56:31 INFO - Running setup.py (path:/tmp/pip-BrG5XE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:56:31 INFO - Running setup.py (path:/tmp/pip-tIdOYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:56:31 INFO - Running setup.py (path:/tmp/pip-uqdSNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:56:31 INFO - Running setup.py (path:/tmp/pip-slJweb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:56:31 INFO - Running setup.py (path:/tmp/pip-YFI1d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:56:31 INFO - Running setup.py (path:/tmp/pip-JO0pW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:56:31 INFO - Running setup.py (path:/tmp/pip-OYdqsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:56:31 INFO - Running setup.py (path:/tmp/pip-eOu1EQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:56:31 INFO - Running setup.py (path:/tmp/pip-NoDG2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:56:31 INFO - Running setup.py (path:/tmp/pip-fBtGmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:56:32 INFO - Running setup.py (path:/tmp/pip-zUHfIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:56:32 INFO - Running setup.py (path:/tmp/pip-BDoc_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:32 INFO - Running setup.py (path:/tmp/pip-R8BAmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:56:32 INFO - Running setup.py (path:/tmp/pip-zoaiIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:56:32 INFO - Running setup.py (path:/tmp/pip-biFHoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:56:32 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)) 15:56:32 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)) 15:56:32 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)) 15:56:32 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)) 15:56:32 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)) 15:56:32 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)) 15:56:32 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)) 15:56:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:56: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 15:56: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 15:56: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 15:56: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 15:56:33 INFO - Downloading blessings-1.6.tar.gz 15:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:56:33 INFO - Installing collected packages: blessings 15:56:33 INFO - Running setup.py install for blessings 15:56:33 INFO - Successfully installed blessings 15:56:33 INFO - Cleaning up... 15:56:33 INFO - Return code: 0 15:56:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:56:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:56:33 INFO - Reading from file tmpfile_stdout 15:56:33 INFO - Current package versions: 15:56:33 INFO - argparse == 1.2.1 15:56:33 INFO - blessings == 1.6 15:56:33 INFO - blobuploader == 1.2.4 15:56:33 INFO - docopt == 0.6.1 15:56:33 INFO - functools32 == 3.2.3-2 15:56:33 INFO - jsonschema == 2.5.1 15:56:33 INFO - manifestparser == 1.1 15:56:33 INFO - mozInstall == 1.13 15:56:33 INFO - mozcrash == 1.0 15:56:33 INFO - mozdebug == 0.1 15:56:33 INFO - mozdevice == 0.51 15:56:33 INFO - mozfile == 1.2 15:56:33 INFO - mozhttpd == 0.7 15:56:33 INFO - mozinfo == 0.10 15:56:33 INFO - mozleak == 0.1 15:56:33 INFO - mozlog == 3.5 15:56:33 INFO - moznetwork == 0.27 15:56:33 INFO - mozprocess == 0.25 15:56:33 INFO - mozprofile == 0.28 15:56:33 INFO - mozrunner == 6.13 15:56:33 INFO - mozscreenshot == 0.1 15:56:33 INFO - mozsystemmonitor == 0.3 15:56:33 INFO - moztest == 0.8 15:56:33 INFO - mozversion == 1.4 15:56:33 INFO - psutil == 3.1.1 15:56:33 INFO - requests == 1.2.3 15:56:33 INFO - wsgiref == 0.1.2 15:56:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:33 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')]} 15:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:33 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')]} 15:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:33 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 0x21491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2312a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9090>, '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 0x24b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b3f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', '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 15:56:33 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 15:56:33 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 15:56:33 INFO - Using env: {'DISPLAY': ':0', 15:56:33 INFO - 'HOME': '/home/cltbld', 15:56:33 INFO - 'LANG': 'en_US.UTF-8', 15:56:33 INFO - 'LANGUAGE': 'en_US:en', 15:56:33 INFO - 'LOGNAME': 'cltbld', 15:56:33 INFO - 'MAIL': '/var/mail/cltbld', 15:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:33 INFO - 'MOZ_NO_REMOTE': '1', 15:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:33 INFO - 'NO_EM_RESTART': '1', 15:56:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:33 INFO - 'PWD': '/builds/slave/test', 15:56:33 INFO - 'SHELL': '/bin/bash', 15:56:33 INFO - 'SHLVL': '1', 15:56:33 INFO - 'TERM': 'linux', 15:56:33 INFO - 'TMOUT': '86400', 15:56:33 INFO - 'USER': 'cltbld', 15:56:33 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', 15:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:33 INFO - '_': '/tools/buildbot/bin/python'} 15:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:34 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)) 15:56:34 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)) 15:56:34 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)) 15:56:34 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)) 15:56:34 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)) 15:56:34 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)) 15:56:34 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)) 15:56:34 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)) 15:56:34 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)) 15:56:34 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:56: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 15:56: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 15:56: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 15:56: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 15:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:56:35 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)) 15:56:35 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)) 15:56:35 INFO - Installing collected packages: simplejson 15:56:35 INFO - Running setup.py install for simplejson 15:56:35 INFO - building 'simplejson._speedups' extension 15:56:35 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 15:56:36 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 15:56:36 INFO - Successfully installed simplejson 15:56:36 INFO - Cleaning up... 15:56:36 INFO - Return code: 0 15:56:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:56:36 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')]} 15:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:36 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')]} 15:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:36 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 0x21491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2312a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b5a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b9090>, '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 0x24b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b3f90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', '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 15:56:36 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 15:56:36 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 15:56:36 INFO - Using env: {'DISPLAY': ':0', 15:56:36 INFO - 'HOME': '/home/cltbld', 15:56:36 INFO - 'LANG': 'en_US.UTF-8', 15:56:36 INFO - 'LANGUAGE': 'en_US:en', 15:56:36 INFO - 'LOGNAME': 'cltbld', 15:56:36 INFO - 'MAIL': '/var/mail/cltbld', 15:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:36 INFO - 'MOZ_NO_REMOTE': '1', 15:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:36 INFO - 'NO_EM_RESTART': '1', 15:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:36 INFO - 'PWD': '/builds/slave/test', 15:56:36 INFO - 'SHELL': '/bin/bash', 15:56:36 INFO - 'SHLVL': '1', 15:56:36 INFO - 'TERM': 'linux', 15:56:36 INFO - 'TMOUT': '86400', 15:56:36 INFO - 'USER': 'cltbld', 15:56:36 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', 15:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:36 INFO - '_': '/tools/buildbot/bin/python'} 15:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:56:36 INFO - Cleaning up... 15:56:36 INFO - Return code: 0 15:56:36 INFO - Running post-action listener: _resource_record_post_action 15:56:36 INFO - Running post-action listener: _start_resource_monitoring 15:56:36 INFO - Starting resource monitoring. 15:56:36 INFO - [mozharness: 2017-09-13 22:56:36.658021Z] Finished create-virtualenv step (success) 15:56:36 INFO - [mozharness: 2017-09-13 22:56:36.658532Z] Running install step. 15:56:36 INFO - Running pre-action listener: _resource_record_pre_action 15:56:36 INFO - Running main action method: install 15:56:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:56:36 INFO - Reading from file tmpfile_stdout 15:56:36 INFO - Detecting whether we're running mozinstall >=1.0... 15:56:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:56:37 INFO - Reading from file tmpfile_stdout 15:56:37 INFO - Output received: 15:56:37 INFO - Usage: mozinstall [options] installer 15:56:37 INFO - Options: 15:56:37 INFO - -h, --help show this help message and exit 15:56:37 INFO - -d DEST, --destination=DEST 15:56:37 INFO - Directory to install application into. [default: 15:56:37 INFO - "/builds/slave/test"] 15:56:37 INFO - --app=APP Application being installed. [default: firefox] 15:56:37 INFO - mkdir: /builds/slave/test/build/application 15:56:37 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'] 15:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:56:54 INFO - Reading from file tmpfile_stdout 15:56:54 INFO - Output received: 15:56:54 INFO - /builds/slave/test/build/application/firefox/firefox 15:56:54 INFO - Running post-action listener: _resource_record_post_action 15:56:54 INFO - [mozharness: 2017-09-13 22:56:54.575210Z] Finished install step (success) 15:56:54 INFO - [mozharness: 2017-09-13 22:56:54.575356Z] Running setup-mitmproxy step. 15:56:54 INFO - Running pre-action listener: _resource_record_pre_action 15:56:54 INFO - Running main action method: setup_mitmproxy 15:56:54 INFO - Skipping: mitmproxy is not required 15:56:54 INFO - Running post-action listener: _resource_record_post_action 15:56:54 INFO - [mozharness: 2017-09-13 22:56:54.575881Z] Finished setup-mitmproxy step (success) 15:56:54 INFO - [mozharness: 2017-09-13 22:56:54.575985Z] Running run-tests step. 15:56:54 INFO - Running pre-action listener: _resource_record_pre_action 15:56:54 INFO - Running pre-action listener: _set_gcov_prefix 15:56:54 INFO - Running main action method: run_tests 15:56:54 WARNING - Try message not found. 15:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:56:54 INFO - Python 2.7.3 15:56:54 INFO - Return code: 0 15:56:54 INFO - grabbing minidump binary from tooltool 15:56:54 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')]} 15:56:54 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 0x24b9090>, '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 0x24b9d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b3f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:56:54 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 15:56:54 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 15:56:54 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 15:56:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:56:54 INFO - Return code: 0 15:56:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:56:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:56:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:56:54 INFO - ENV: RUST_BACKTRACE is now full 15:56:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:56:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:56:54 INFO - Using env: {'DISPLAY': ':0', 15:56:54 INFO - 'HOME': '/home/cltbld', 15:56:54 INFO - 'LANG': 'en_US.UTF-8', 15:56:54 INFO - 'LANGUAGE': 'en_US:en', 15:56:54 INFO - 'LOGNAME': 'cltbld', 15:56:54 INFO - 'MAIL': '/var/mail/cltbld', 15:56:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:56:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:54 INFO - 'MOZ_NO_REMOTE': '1', 15:56:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:54 INFO - 'NO_EM_RESTART': '1', 15:56:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:54 INFO - 'PWD': '/builds/slave/test', 15:56:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:56:54 INFO - 'RUST_BACKTRACE': 'full', 15:56:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:56:54 INFO - 'SHELL': '/bin/bash', 15:56:54 INFO - 'SHLVL': '1', 15:56:54 INFO - 'TERM': 'linux', 15:56:54 INFO - 'TMOUT': '86400', 15:56:54 INFO - 'USER': 'cltbld', 15:56:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', 15:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:54 INFO - '_': '/tools/buildbot/bin/python'} 15:56:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:56:54 INFO - mozversion application_buildid: 20170913213200 15:56:54 INFO - mozversion application_changeset: 0e706b53052c86b247bb8037d1a3fbf2e913045e 15:56:54 INFO - mozversion application_display_name: Nightly 15:56:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:56:54 INFO - mozversion application_name: Firefox 15:56:54 INFO - mozversion application_remotingname: firefox 15:56:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:56:54 INFO - mozversion application_vendor: Mozilla 15:56:54 INFO - mozversion application_version: 57.0a1 15:56:54 INFO - mozversion platform_buildid: 20170913213200 15:56:54 INFO - mozversion platform_changeset: 0e706b53052c86b247bb8037d1a3fbf2e913045e 15:56:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:56:54 INFO - mozversion platform_version: 57.0a1 15:56:54 INFO - using testdate: 1505343414 15:56:54 INFO - actual date: 1505343414 15:56:54 INFO - starting webserver on 'localhost:58694' 15:56:54 INFO - SUITE-START | Running 2 tests 15:56:54 INFO - TEST-START | dromaeo_css 15:56:54 INFO - Initialising browser for dromaeo_css test... 15:56:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58694/getInfo.html -profile /tmp/tmpeSaFmr/profile 15:56:54 INFO - TEST-INFO | started process 22713 (/builds/slave/test/build/application/firefox/firefox http://localhost:58694/getInfo.html) 15:57:01 INFO - TEST-INFO | 22713: exit 0 15:57:01 INFO - Browser initialized. 15:57:01 INFO - Running cycle 1/1 for dromaeo_css test... 15:57:01 INFO - Using env: {'DISPLAY': ':0', 15:57:01 INFO - 'HOME': '/home/cltbld', 15:57:01 INFO - 'JSGC_DISABLE_POISONING': '1', 15:57:01 INFO - 'LANG': 'en_US.UTF-8', 15:57:01 INFO - 'LANGUAGE': 'en_US:en', 15:57:01 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:57:01 INFO - 'LOGNAME': 'cltbld', 15:57:01 INFO - 'MAIL': '/var/mail/cltbld', 15:57:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:57:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:57:01 INFO - 'MOZ_CRASHREPORTER': '1', 15:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:01 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:57:01 INFO - 'MOZ_NO_REMOTE': '1', 15:57:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:01 INFO - 'NO_EM_RESTART': '1', 15:57:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:01 INFO - 'PWD': '/builds/slave/test', 15:57:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:57:01 INFO - 'RUST_BACKTRACE': 'full', 15:57:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:57:01 INFO - 'SHELL': '/bin/bash', 15:57:01 INFO - 'SHLVL': '1', 15:57:01 INFO - 'TERM': 'linux', 15:57:01 INFO - 'TMOUT': '86400', 15:57:01 INFO - 'USER': 'cltbld', 15:57:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', 15:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:01 INFO - '_': '/tools/buildbot/bin/python'} 15:57:01 INFO - TEST-INFO | started process 22950 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeSaFmr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:57:02 INFO - PID 22950 | 15:57:02 INFO - PID 22950 | (/builds/slave/test/build/application/firefox/firefox:23003): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:57:02 INFO - PID 22950 | 15:57:12 INFO - PID 22950 | RSS: Main: 167534592 15:57:12 INFO - PID 22950 | 16:00:09 INFO - PID 22950 | Cycle 1(1): loaded http://localhost:58694/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58694/tests/dromaeo/cssquery-ext.html) 16:00:10 INFO - PID 22950 | RSS: Main: 171487232 16:00:10 INFO - PID 22950 | 16:03:12 INFO - PID 22950 | Cycle 1(1): loaded http://localhost:58694/tests/dromaeo/cssquery-ext.html (next: http://localhost:58694/tests/dromaeo/cssquery-jquery.html) 16:03:12 INFO - PID 22950 | RSS: Main: 167530496 16:03:12 INFO - PID 22950 | 16:06:14 INFO - PID 22950 | Cycle 1(1): loaded http://localhost:58694/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58694/tests/dromaeo/cssquery-mootools.html) 16:06:15 INFO - PID 22950 | RSS: Main: 170381312 16:06:15 INFO - PID 22950 | 16:09:16 INFO - PID 22950 | Cycle 1(1): loaded http://localhost:58694/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58694/tests/dromaeo/cssquery-prototype.html) 16:09:17 INFO - PID 22950 | RSS: Main: 168370176 16:09:17 INFO - PID 22950 | 16:12:20 INFO - PID 22950 | Cycle 1(1): loaded http://localhost:58694/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58694/tests/dromaeo/cssquery-yui.html) 16:12:21 INFO - PID 22950 | RSS: Main: 169897984 16:12:21 INFO - PID 22950 | 16:15:22 INFO - PID 22950 | Cycle 1(1): loaded http://localhost:58694/tests/dromaeo/cssquery-yui.html (next: http://localhost:58694/tests/dromaeo/cssquery-dojo.html) 16:15:22 INFO - PID 22950 | RSS: Main: 172716032 16:15:22 INFO - PID 22950 | 16:15:22 INFO - PID 22950 | __start_tp_report 16:15:22 INFO - PID 22950 | _x_x_mozilla_page_load 16:15:22 INFO - PID 22950 | _x_x_mozilla_page_load_details 16:15:22 INFO - PID 22950 | |i|pagename|runs| 16:15:22 INFO - PID 22950 | |0;dojo.html;3810.5808361080285;3845.3655146900755;3854.3447613905632;3862.690984721223;3899.0447340401606;6198.78304259351;6290.119383286338;6313;6339.778107766229;6370.076338930858;6278.434940855322;6304.558680892339;6392.968035159818;6405.039244113385;6430.871382572357;145.33284486021088;5570.721463926808;5599.1041433370665;5623;5644.01229784788;5507.228987941671;5521.5306698930635;5605.803796867111;5618.550515958714;5623.80316688916;5484.478974497416;5516.586256030773;5532.640378375393;5589.329280486348;5604.663720176803;5510.283663123809;5542.75057622408;5624.3813180550105;5625.128105143709;5629.746661400247;5543;5546.362168350651;5609.663420194802;5613.803516876889;5633.718314084321;6157.2919114301985;6192.721327540272;6192.938070619326;6264.27960784511;6291.02489114188;6662.56693314933;6774.119364482635;6790.660466976681;6863.794086177422;6876.724931002804;6931.653417329164;7025;7046.894296585555;7053.0830991970715;7069.787906362817;6340.175777148987;6430.7749228776765;6489.805305840785;6518.152640156797;6524.314946930599;6927.203371612329;7022.227554968949;7023.367896889305;7069.82325441868;7070.646467676698;6769.458443324522;6805.931940680629;6874.759383421556;6897.1033765611155;6902.378785909293;6642.136522252076;6749.291324410964;6883.27725588806;6920.688569014305;6991.056207411934;6326.9683651581445;6887.483438742014;6895.655217239118;6905.585664860125;6918.688659010357;6771.932280677229;6867.965660171767;6871.175458944958;6871.9656401717675;6936;4974.204127339608;5005;5009.248612708123;5040.621953353513;5081.339425874687;4450.399196108484;4505.819767209275;4528.320751887178;4561.201789686792;4598.678092533558;6140.846478838065;6172.845678858064;6177.722002509898;6203.069539569101;6203.31763506014;6714.429273511806;6794.93205067943;6897.862042759117;6901.75843845463;6908.585484870924;6013.51891848651;6146.754129834846;6165.414285642857;6255.186825712628;6260;5477.643953143033;5541.5843811714285;5542.196381524656;5545.390007099216;5554.944450555443;7035.47233957445;7036.472264580177;7091.858162836715;7118.145822501229;7127.180374257026;6721;6834.316568343126;6837.863242735217;6888.793336199922;6915.688794004282;6974.755883544051;7030.543014704028;7100.538464999759;7110.5022648414115;7156.463265255023;6821.488388370793;6914.654267286515;6923.9307606923285;6940.479464040318;6956.37392634645;6764.086848275617;6900.413464855544;6902.482313826584;6906.412954898889;6988.266232045562;6578.605283682994;6579.901301480386;6598.208215014229;6612.272650008592;6620;6563.245226798788;6571.605703657796;6572.507061970276;6572.868542629216;6574.901376479261;6387;6406.903896441464;6429.03564465334;6471.158749362553;6488.935110649022;6654.866902661823;6662.200535935525;6677.09859169006;6694.665266736741;6768.357006084414;6336;6454.741810327534;6533.542652014504;6547.574407663486;6550.312217217314 16:15:22 INFO - PID 22950 | |1;ext.html;898.384606544517;933.4959122074081;946.077574364994;978.0415193110751;983.1053741095602;41605;42115.57884421155;42353;42691.14617707648;42748.78625606871;39676.40485392721;39753.20493590127;39944.80027599865;40015.199696006064;40087;7297.890531642016;7411.444141689368;7412.221716719748;7420.925790742104;7428.442866784986;7374.631268436584;7461.477696561243;7490.176080631126;7491.6254187290415;7498.925010749877;7907.486013409139;8091.19088091192;8092.473989190713;8104.351651867836;8105.594720263993;8014.7194848180325;8042.517448953023;8054.677812887478;8088.716894908679;8090.595470226494;7939.206079392073;7944.801379965489;8016.35869130474;8040.115587285394;8048.919510804875;39329;39661.00847478836;39675.20649586992;39684.60315396838;39750.20499589992;3301.422251106047;3356.6139893912023;3360.2439451123546;3360.815155166465;3367.9158021049425;33143.83428082868;33181.3363732724;33296;33328.1667958303;33374.165645858804;5409.161579955074;5427.701476418795;5453.509184173404;5462.426445223234;5494.615376923617;209550;210815;210962;211310;211668;50806.491935080914;50957.74521127371;51064;51203.487965120614;51890.48109518857;54354.45645543573;54537.45462545324;54554;54584.181237281475;54633;16611.335546578244;16739.748903766453;16746.1626918656;16751.581210469834;16761.832381676028;13485.190888546718;13498.865011349957;13501.83970564705;13504.864951350557;13562.321883905764;14772;14782.556523304318;14808.777868331983;14851.628709282355;14924.477643282433;5715.571332150105;5748.166515855178;5836.023627949691;5860.00379935412;5922.437368450077;1089.1722291058852;1098.5880294889416;1099.1591432554103;1107.5735841700841;1114.7714718482691;24787.25638230856;25229.369265768135;25255.87372063128;25281;25345.49309013846;1191.0531127753457;1191.6127258640977;1193.4450480526598;1201.8798120188087;1226.0926914083514;12972.729772289811;13340.799888001688;13397.26315052662;13408.396622152026;13412.597622071353;290118;291143;291622;293682;294499;56135;57998;62207.37792622107;62287;62490;1498.6328349554428;1514.6516301250774;1516.6814968856443;1520.8783297336186;1522.528016314946;30122.849385752932;30221.69778302189;30376;30450.695493044786;30531.084067478012;40582.39126413165;40992.79503602463;41078.58921410747;41117.383239252034;41195.58804411918;251801;252597;252723;252829;253289;35977.64022359848;36015.27969440544;36199.63800362068;36224.456633149995;36451.27097458089;44615.55384446244;46828;46898.53101468942;46957.06085878332;47061;33695.15762105967;33803.98588042363;34059;34292.82853585716;34425.31149377049;33577.83211083929;33730.49404258889;33813.66186338105;34331.31337373288;34356.312873742885;39284;39292.60707393004;39332.410013850385;39380.606193937696;39460.60539394569;32701.836490817393;33210.667893321726;33317.333653326314;33431.49852752259;33531.497027544116;24567.508649826545;25265.368365791;25283.494330113663;25380.365490862878;25694.229173124837 16:15:22 INFO - PID 22950 | |2;jquery.html;581.6708820345511;590.852286928268;592.1473078766574;593.4273426143772;604.9992039484158;22809;23695.881520592393;23733.881330593365;23737.406564835866;23744.931478083483;24486.387840304;25770.484590308184;27106.32234194146;27110.5933410999;27160.86419567904;6528.249251336086;6561.573497722657;6611.603303801763;6637.634930078843;6641.601503909781;6491.967540162316;6522.445592124675;6580.638064906429;6761.323867613249;6787.898181527281;6748.898766518481;6760.695768690396;6762.864742705143;6763.5941843489545;6769.661516924159;6767.289434609344;6767.796966091;6774.695138718745;6776.525643205002;6782.016607591921;6301.464375528086;6312.400321969406;6330.272018717815;6335.429811317003;6346.682665866734;29834.701652983626;30361.69638303611;30831.537526937114;31471.213219669462;31662.208444788834;2271.216430331533;2294.8508346957396;2296.2537175418056;2296.9310920672406;2298.712660917385;20452;21091.8945405272;21136.365909022756;22057.889710551506;22061.889690551605;2512.208654273898;2522.14247155966;2536.518061568296;2591.2485379239997;2609.856457894815;131242;135557.3222133893;158305;166169;166323;15203.818949788896;15773.369065237492;15864.92067539678;16384.672306553803;17832.732509012374;25805.870970645403;25812.934965202738;25874.35314117162;25937.351566210997;25947.351316217246;9666;9816.460094694718;9875.259355548362;10011.249156313306;10049.447280399649;8756.430831996027;8833.60248788806;8868.379213454997;8909.198172164537;8910.420822646507;9217.170454659114;9628;9672;9753.65862194834;10023.34848234877;2709.1330774152475;2723.496153211662;2726.2601085908536;2825.110090321542;2864.957025644617;1030.2685093583639;1044.639599338227;1046.5970601318547;1047.638564695179;1058.090042563395;21069.683954740693;21128.049237784337;21149.25977590777;21376.786232137478;21647.67528487074;1083.3337497439177;1099.9560017599206;1105.3202280597375;1107.180686292138;1109.9278546894427;11814.409279536161;11861;11929.22460040112;11936.164468487295;12121.454534545966;597806;598494;613530;628880;638754;121837.39081304714;122515;124040;124662.37668811779;128211.35894320469;1098.357460885391;1144.3934714601276;1215.7629262293767;1234.0682784497646;1281.1416351044822;22190.334289971328;22782.20262290812;22901.427464313525;22921.541569168858;22960.54078918379;62539;63203.6839815798;64055.35944640494;64392;64516.67741661262;79810.60094699722;79926.20073799188;80371;80739;81044;15287.847121529087;15827.52517424479;15830.129342886252;15848.683026339178;15849.049057056614;23159.6526052106;23393.181238657246;24829.130980415597;25044.74955250497;25199.496010080064;19912.203511859363;19925.302614408425;20047.599048018667;20057.197712091936;20251;17642.470725878244;17762.37831675885;17847.196876140344;17878.106094695475;18132.818671813115;20268.89865550663;20531;20642;20672.069756860677;20672.689909651068;15473.767893481381;15517.689646207238;15541.37834486653;15546.611334716723;15553.611159721098;19471.123799429344;19723.112459939624;19756.60486790285;19764.40706778799;19768.90115549413 16:15:22 INFO - PID 22950 | |3;mootools.html;1392.6448755567333;1457.613732360924;1459.83211930628;1474.498670452046;1483.7403454395478;16772.83227167728;17461.3015479381;17484.737728934077;17492.12539373031;17506.212220450077;16717.414890478834;16802.15989200538;16816;16825.242864071115;16825.99999999997;2874.6694130174983;2878.150945471091;2928.88284468621;2930.238138084103;2930.912072637824;2770.279727270914;2831.6602007759097;2840.2899275181203;2842.147355793264;2849.7720182385465;2588.741125887415;2718.130198336533;2798.468291024709;2821.4216085702483;2829.2643912582776;2845.430913817245;2882.4235152969386;2916.533354663254;2917.606123173387;2919.357741296911;2579.8968041278326;2753.931151721223;2762;2807.73326533981;2824.830510169376;16689.415870444598;16767.496975090766;16859.494215173563;16890.577735556588;16896.915515422344;8284.130166332568;8473.491590504527;8499.235068843773;8604.827903441896;8622.137786221328;5321.281626980347;5441.972790136024;5552.694601796899;5683.437054809919;5694.288213973254;2058.711780350752;2067.917283308666;2108.156737305075;2124.5538436928264;2156.3207589609224;30211.69788302111;30347;30618;30663.38673226523;30695.38609227825;7216.061911951518;7260.346568808833;7342.743003994835;7522.398208143335;7547.735829246059;19969.101390437467;19987.20051197965;20001.899990499955;20005.099770510362;20008;8512.957435212784;8713.695020674246;8720.825583488422;8744.387892847439;8747.606357713918;7626.351760100453;7728.227177282227;7749.961250193713;7754.689812407553;7774.416918731004;5795.565332600072;5903.114532820111;6013.398660133952;6068.120122582289;6069.726862291208;1861.4415675297357;1890.1966664167674;1890.5611760828378;1922.3848368522217;1935.0421541337128;967.8209531236744;982.8230918434607;983.1692220074169;985.2905907746411;1011.6004178349658;8557.78605534854;8647.264982476434;8666.696665616673;8758.781030474162;8768.123187681182;776.6621519638975;782.8003859015914;785.4109417936547;794.8608993426127;800.0599295827379;4833.154198015333;4969.577585905166;4981.526754958273;5921.822345329647;6042.879142417215;23598.17406390768;23718.644220336708;24681.62977555302;24783.87608061948;24804.627930581057;23614;23985.400364991016;24487.142949996665;24615;24677;12045;12205.084618653636;12345.753084938251;12358.567450139382;12362.567310144103;8992.685256016008;9019.143181397756;9031.593578288861;9060.411073280216;9080.954595226982;20431;20558.486037849172;20701.378958631267;21194.894025529775;21310;21156.153753849674;21487.677684835053;21631.35105946824;21671.458213544156;21749.673754893374;13336.799948000593;13465.39405726725;13468.865311347154;13477;13486.190828550318;14809.111453312837;14906.925465373037;14921.701565968402;15110.697786044437;15136.167510787012;12148.75702485963;12148.817767733315;12297.200681955645;12529.37353132358;12582.748345033231;11709.824352634887;11822.645320640395;12025.579104731292;12168.756624867276;12444.253344798979;10839.187060970302;11063.50214240345;11065.446727663424;11076.169287303323;11086.667399978014;8305.626246818787;8337.374696897878;8365.581720914051;8386.161383861809;8511.106333834858;7826.178251283533;7894.644740986554;7957.846112313798;7976.641051152828;8101.594920253846 16:15:22 INFO - PID 22950 | |4;prototype.html;541.2746919128368;545.5117669685629;565.9009673307171;578.7222133375976;579.2556564814212;6099.268087829461;6153.2923713772925;6278.9372106278925;6306.558540902127;6317.399847014538;6010.188624535686;6153.323134455218;6223.595466294688;6251.562390632646;6279.466245369149;4801.207800712878;5052.797888084481;5056.721880296583;5078.619103567247;5082.491750824925;4859.684120532172;4896.1186986342445;4911.82808601699;4913.803447862099;4918.557329840313;4860.270959356108;4882.633802464811;4921.729304888229;4935.235038569028;4963.45402005779;4886.828960986366;4902.65681402302;4904.656674032819;4940.456549779521;4947.307376967227;4489.618382437497;4496.752678602676;4505.977470112662;4511.932321015187;4513.300438432048;6061.121137435047;6147.170132032164;6153.446189842891;6218.502519798405;6227.283862355796;5845.415458454163;5862.824115276549;5866.794662186803;5870.735816888207;5891.941080589182;6588.538802283842;6657.833554161136;6667.699953502104;6681.231658359302;6701.396874281338;5008.62435317349;5052.115879721071;5058.3443692061965;5065.822696205652;5070;6808.3191680832015;6938.653067346612;6963.16442026955;6981.650917454158;7036.437085033185;5058.873528161752;5065.164247899129;5081.136206844845;5110.770015349318;5121.74391280442;5159.787449949259;5179.792808287626;5184.222366645034;5198.090334191501;5199.1266506452175;5748.425157484218;5759.6832174229985;5759.85600359986;5784.768609255667;5808.303003639506;6318;6416.454601358843;6576.473882089422;6598.439132673777;6619.172603424572;1959.7844237133904;1960.735300734411;1968.252064215589;1968.3406058970406;1981.5937732764748;1463.2318033032743;1487.5091219897408;1490.5304828978838;1498.6028702393874;1505.4268289637355;6016.69916504173;6062.363451837494;6085.452309292096;6098.207233059674;6130.478909292671;6639.468842492589;6675.9332406676285;6722.226943901514;6722.798316050526;6727.159105111861;6036.5170786336985;6059.818205453756;6074.210352654127;6077.20996270482;6098.1157732128595;3485.5360748485696;3520.383932811748;3546.893593192157;3559.2169722660974;3586.318599466093;6920.653967301615;6934.410575101072;6980.825479362955;6989.37095661393;7013.26360732126;6873.759418420332;6900.827479313058;6963.199232088375;6968.7804634188815;6978.371946524837;6930.8613827724175;6948.478864085113;6959;6979.987901754319;7070.984769340713;6683.732650693918;6703.195616526048;6749.190097188369;6752.223494298022;6752.831179220559;6572.277049524453;6587.604743715392;6617.338266173344;6653.567518111501;6723.731050757915;6856;6873.965630172017;6919.273476284918;6924.134483189601;6955.304469553004;5568.777248909998;5583.637063590853;5607.271054762855;5611.158326251095;5626.831195064155;6370.58591191571;6456.225252969673;6684.364985326386;6729.394354508117;6750.683616694698;6503.496153980657;6521.7065232065615;6524.706388212637;6530.216374035146;6555.000724778988;6440.29156792743;6466.838329041811;6530.869382612416;6538;6548.410643042149;6360.936390636034;6399.6800159992745;6491.188601424822;6512.837179070561;6523.18460192476;6526.282108968105;6556.934969986847;6586.176727909012;6592.43964263043;6654.633995130121;6300.842478938063;6345.206849143857;6358.841028974312;6363.172787537591;6407.487401007815 16:15:22 INFO - PID 22950 | |5;yui.html;927.1933417926405;955.8375076237039;959.7648576098861;967.6516454076532;982.3172894838088;18647.813521864777;19644.508887277807;19666.90166549167;19702.704459433084;19736.802631973675;16891.83108168918;17683.734743978817;17820.64358712825;17821.287148514075;17828.82171178288;1031.577053408101;1051.1538211739546;1052.3212527919488;1053.3627155570846;1055.3773273768475;1004.5730564510054;1032.1742605915238;1062.8352605346183;1066.3548553125363;1069.6470164845582;1124.432161758315;1127.8421021057059;1128.3004537186955;1130.773845230953;1132.0717012050081;1055.4036969112426;1098.1763677242068;1127.5320741892106;1128.3568366031325;1131.1516362727955;805.3476683886071;809.9716509922124;810.4812919731377;810.9959450202712;811.0227176252602;19372.4188274352;19640.01799910013;19645.508862278413;19653.803461965483;19677.409677709693;22468;23021.309360719206;23186.884065579732;23245.186418475274;23277.06891724329;17417.30330786767;18334.816651833444;18412.447626571226;18433.90783046076;18507.35224267144;4056.776877271749;4081.5306239782212;4092.202020605983;4092.5702801205744;4095.52901416335;155846.22076889657;156258;156605;159161;161653;17158.142092895556;17233.39683111085;17315.480535583953;17377.56556086083;17869.195886185153;27091.593626095626;27103.593446098323;27109.32226694309;27214.911403544033;30683.8465807674;7632.389408847279;7668.463207575416;7771.300582947561;7791.4156438267355;7817.726379576688;4432.13573353193;4494.415725955605;4500.302453119772;4500.482444518857;4504.752238626841;5961.718230580359;6005.219321488266;6018.277806663228;6074.149619053248;6175.413335733098;1000.2498126405196;1015.6749840051112;1033.426448321174;1033.612395351743;1042.2391654092555;691.1188235000415;703.2791388826494;711.1643818513227;713.5540287320425;718.9137303523611;11890.28658280506;11991.340476273714;12062.638120856212;12253.509859605516;12832.679183020498;703.2299631903059;716.0726858717973;720.3372896934833;728.9635518224068;731.1445608637906;5624.29696287964;5629.437056294338;5630.5214056805635;5720.370759216483;5774.913376299359;145318;147197.2640136814;147299.2635036818;151312.2434387821;153463.23268383587;134390;136205;137423;138969.30515347357;143188;116583;117121;118571;119355.40322298332;119403.820866271;10709.678709638723;10816.67549973502;10852.67441976742;10911.072558832588;11121.83317250258;56023.719881401965;56247;56851.71574142103;57919;59238;70346.29653703602;70828.64585677245;72389.63805180941;72549;72922.27077729155;16119;16502;16580.668386632442;16596.75104873452;16599.41902033423;18444.446666600023;18670.43988680342;18861.811381886004;18869.43391698251;18883.05584720786;16053;16168.272427740545;16178.838211617733;16286.755698664292;16297.511074667778;15853.207339633203;16188;16202.91898540547;16271.430499932445;16326.265318060478;13586.728265434438;13786.724265514835;13805.51680691171;13811.309434528433;13906.096103753223;11500.48247828833;11566.901144391606;11627.767444651228;11873.940630296793;11998.160128790902;11969.74843647004;12143.332116733665;12462.43919023628;12512.37438128108;12592.622221333375 16:15:22 INFO - PID 22950 | __end_tp_report 16:15:22 INFO - PID 22950 | __start_cc_report 16:15:22 INFO - PID 22950 | _x_x_mozilla_cycle_collect,351 16:15:22 INFO - PID 22950 | __end_cc_report 16:15:22 INFO - PID 22950 | __startTimestamp1505344522939__endTimestamp 16:15:22 INFO - PID 22950 | 16:15:22 INFO - PID 22950 | ------- Summary: start ------- 16:15:22 INFO - PID 22950 | Number of tests: 6 16:15:22 INFO - PID 22950 | 16:15:22 INFO - PID 22950 | [#0] dojo.html Cycles:165 Average:6243.86 Median:6524.31 stddev:904.85 (13.9%) stddev-sans-first:887.26 16:15:22 INFO - PID 22950 | Values: 3810.6 3845.4 3854.3 3862.7 3899.0 6198.8 6290.1 6313.0 6339.8 6370.1 6278.4 6304.6 6393.0 6405.0 6430.9 145.3 5570.7 5599.1 5623.0 5644.0 5507.2 5521.5 5605.8 5618.6 5623.8 5484.5 5516.6 5532.6 5589.3 5604.7 5510.3 5542.8 5624.4 5625.1 5629.7 5543.0 5546.4 5609.7 5613.8 5633.7 6157.3 6192.7 6192.9 6264.3 6291.0 6662.6 6774.1 6790.7 6863.8 6876.7 6931.7 7025.0 7046.9 7053.1 7069.8 6340.2 6430.8 6489.8 6518.2 6524.3 6927.2 7022.2 7023.4 7069.8 7070.6 6769.5 6805.9 6874.8 6897.1 6902.4 6642.1 6749.3 6883.3 6920.7 6991.1 6327.0 6887.5 6895.7 6905.6 6918.7 6771.9 6868.0 6871.2 6872.0 6936.0 4974.2 5005.0 5009.2 5040.6 5081.3 4450.4 4505.8 4528.3 4561.2 4598.7 6140.8 6172.8 6177.7 6203.1 6203.3 6714.4 6794.9 6897.9 6901.8 6908.6 6013.5 6146.8 6165.4 6255.2 6260.0 5477.6 5541.6 5542.2 5545.4 5554.9 7035.5 7036.5 7091.9 7118.1 7127.2 6721.0 6834.3 6837.9 6888.8 6915.7 6974.8 7030.5 7100.5 7110.5 7156.5 6821.5 6914.7 6923.9 6940.5 6956.4 6764.1 6900.4 6902.5 6906.4 6988.3 6578.6 6579.9 6598.2 6612.3 6620.0 6563.2 6571.6 6572.5 6572.9 6574.9 6387.0 6406.9 6429.0 6471.2 6488.9 6654.9 6662.2 6677.1 6694.7 6768.4 6336.0 6454.7 6533.5 6547.6 6550.3 16:15:22 INFO - PID 22950 | 16:15:22 INFO - PID 22950 | [#1] ext.html Cycles:180 Average:42735.26 Median:35996.46 stddev:66175.53 (183.8%) stddev-sans-first:66286.61 16:15:22 INFO - PID 22950 | Values: 898.4 933.5 946.1 978.0 983.1 41605.0 42115.6 42353.0 42691.1 42748.8 39676.4 39753.2 39944.8 40015.2 40087.0 7297.9 7411.4 7412.2 7420.9 7428.4 7374.6 7461.5 7490.2 7491.6 7498.9 7907.5 8091.2 8092.5 8104.4 8105.6 8014.7 8042.5 8054.7 8088.7 8090.6 7939.2 7944.8 8016.4 8040.1 8048.9 39329.0 39661.0 39675.2 39684.6 39750.2 3301.4 3356.6 3360.2 3360.8 3367.9 33143.8 33181.3 33296.0 33328.2 33374.2 5409.2 5427.7 5453.5 5462.4 5494.6 209550.0 210815.0 210962.0 211310.0 211668.0 50806.5 50957.7 51064.0 51203.5 51890.5 54354.5 54537.5 54554.0 54584.2 54633.0 16611.3 16739.7 16746.2 16751.6 16761.8 13485.2 13498.9 13501.8 13504.9 13562.3 14772.0 14782.6 14808.8 14851.6 14924.5 5715.6 5748.2 5836.0 5860.0 5922.4 1089.2 1098.6 1099.2 1107.6 1114.8 24787.3 25229.4 25255.9 25281.0 25345.5 1191.1 1191.6 1193.4 1201.9 1226.1 12972.7 13340.8 13397.3 13408.4 13412.6 290118.0 291143.0 291622.0 293682.0 294499.0 56135.0 57998.0 62207.4 62287.0 62490.0 1498.6 1514.7 1516.7 1520.9 1522.5 30122.8 30221.7 30376.0 30450.7 30531.1 40582.4 40992.8 41078.6 41117.4 41195.6 251801.0 252597.0 252723.0 252829.0 253289.0 35977.6 36015.3 36199.6 36224.5 36451.3 44615.6 46828.0 46898.5 46957.1 47061.0 33695.2 33804.0 34059.0 34292.8 34425.3 33577.8 33730.5 33813.7 34331.3 34356.3 39284.0 39292.6 39332.4 39380.6 39460.6 32701.8 33210.7 33317.3 33431.5 33531.5 24567.5 25265.4 25283.5 25380.4 25694.2 16:15:22 INFO - PID 22950 | 16:15:22 INFO - PID 22950 | [#2] jquery.html Cycles:180 Average:40062.57 Median:23544.53 stddev:102795.84 (436.6%) stddev-sans-first:103041.46 16:15:22 INFO - PID 22950 | Values: 581.7 590.9 592.1 593.4 605.0 22809.0 23695.9 23733.9 23737.4 23744.9 24486.4 25770.5 27106.3 27110.6 27160.9 6528.2 6561.6 6611.6 6637.6 6641.6 6492.0 6522.4 6580.6 6761.3 6787.9 6748.9 6760.7 6762.9 6763.6 6769.7 6767.3 6767.8 6774.7 6776.5 6782.0 6301.5 6312.4 6330.3 6335.4 6346.7 29834.7 30361.7 30831.5 31471.2 31662.2 2271.2 2294.9 2296.3 2296.9 2298.7 20452.0 21091.9 21136.4 22057.9 22061.9 2512.2 2522.1 2536.5 2591.2 2609.9 131242.0 135557.3 158305.0 166169.0 166323.0 15203.8 15773.4 15864.9 16384.7 17832.7 25805.9 25812.9 25874.4 25937.4 25947.4 9666.0 9816.5 9875.3 10011.2 10049.4 8756.4 8833.6 8868.4 8909.2 8910.4 9217.2 9628.0 9672.0 9753.7 10023.3 2709.1 2723.5 2726.3 2825.1 2865.0 1030.3 1044.6 1046.6 1047.6 1058.1 21069.7 21128.0 21149.3 21376.8 21647.7 1083.3 1100.0 1105.3 1107.2 1109.9 11814.4 11861.0 11929.2 11936.2 12121.5 597806.0 598494.0 613530.0 628880.0 638754.0 121837.4 122515.0 124040.0 124662.4 128211.4 1098.4 1144.4 1215.8 1234.1 1281.1 22190.3 22782.2 22901.4 22921.5 22960.5 62539.0 63203.7 64055.4 64392.0 64516.7 79810.6 79926.2 80371.0 80739.0 81044.0 15287.8 15827.5 15830.1 15848.7 15849.0 23159.7 23393.2 24829.1 25044.7 25199.5 19912.2 19925.3 20047.6 20057.2 20251.0 17642.5 17762.4 17847.2 17878.1 18132.8 20268.9 20531.0 20642.0 20672.1 20672.7 15473.8 15517.7 15541.4 15546.6 15553.6 19471.1 19723.1 19756.6 19764.4 19768.9 16:15:22 INFO - PID 22950 | 16:15:22 INFO - PID 22950 | [#3] mootools.html Cycles:180 Average:10363.33 Median:2766.14 stddev:7628.35 (275.8%) stddev-sans-first:7619.98 16:15:22 INFO - PID 22950 | Values: 1392.6 1457.6 1459.8 1474.5 1483.7 16772.8 17461.3 17484.7 17492.1 17506.2 16717.4 16802.2 16816.0 16825.2 16826.0 2874.7 2878.2 2928.9 2930.2 2930.9 2770.3 2831.7 2840.3 2842.1 2849.8 2588.7 2718.1 2798.5 2821.4 2829.3 2845.4 2882.4 2916.5 2917.6 2919.4 2579.9 2753.9 2762.0 2807.7 2824.8 16689.4 16767.5 16859.5 16890.6 16896.9 8284.1 8473.5 8499.2 8604.8 8622.1 5321.3 5442.0 5552.7 5683.4 5694.3 2058.7 2067.9 2108.2 2124.6 2156.3 30211.7 30347.0 30618.0 30663.4 30695.4 7216.1 7260.3 7342.7 7522.4 7547.7 19969.1 19987.2 20001.9 20005.1 20008.0 8513.0 8713.7 8720.8 8744.4 8747.6 7626.4 7728.2 7750.0 7754.7 7774.4 5795.6 5903.1 6013.4 6068.1 6069.7 1861.4 1890.2 1890.6 1922.4 1935.0 967.8 982.8 983.2 985.3 1011.6 8557.8 8647.3 8666.7 8758.8 8768.1 776.7 782.8 785.4 794.9 800.1 4833.2 4969.6 4981.5 5921.8 6042.9 23598.2 23718.6 24681.6 24783.9 24804.6 23614.0 23985.4 24487.1 24615.0 24677.0 12045.0 12205.1 12345.8 12358.6 12362.6 8992.7 9019.1 9031.6 9060.4 9081.0 20431.0 20558.5 20701.4 21194.9 21310.0 21156.2 21487.7 21631.4 21671.5 21749.7 13336.8 13465.4 13468.9 13477.0 13486.2 14809.1 14906.9 14921.7 15110.7 15136.2 12148.8 12148.8 12297.2 12529.4 12582.7 11709.8 11822.6 12025.6 12168.8 12444.3 10839.2 11063.5 11065.4 11076.2 11086.7 8305.6 8337.4 8365.6 8386.2 8511.1 7826.2 7894.6 7957.8 7976.6 8101.6 16:15:22 INFO - PID 22950 | 16:15:22 INFO - PID 22950 | [#4] prototype.html Cycles:180 Average:5613.15 Median:6153.38 stddev:1537.59 (25.0%) stddev-sans-first:1494.03 16:15:22 INFO - PID 22950 | Values: 541.3 545.5 565.9 578.7 579.3 6099.3 6153.3 6278.9 6306.6 6317.4 6010.2 6153.3 6223.6 6251.6 6279.5 4801.2 5052.8 5056.7 5078.6 5082.5 4859.7 4896.1 4911.8 4913.8 4918.6 4860.3 4882.6 4921.7 4935.2 4963.5 4886.8 4902.7 4904.7 4940.5 4947.3 4489.6 4496.8 4506.0 4511.9 4513.3 6061.1 6147.2 6153.4 6218.5 6227.3 5845.4 5862.8 5866.8 5870.7 5891.9 6588.5 6657.8 6667.7 6681.2 6701.4 5008.6 5052.1 5058.3 5065.8 5070.0 6808.3 6938.7 6963.2 6981.7 7036.4 5058.9 5065.2 5081.1 5110.8 5121.7 5159.8 5179.8 5184.2 5198.1 5199.1 5748.4 5759.7 5759.9 5784.8 5808.3 6318.0 6416.5 6576.5 6598.4 6619.2 1959.8 1960.7 1968.3 1968.3 1981.6 1463.2 1487.5 1490.5 1498.6 1505.4 6016.7 6062.4 6085.5 6098.2 6130.5 6639.5 6675.9 6722.2 6722.8 6727.2 6036.5 6059.8 6074.2 6077.2 6098.1 3485.5 3520.4 3546.9 3559.2 3586.3 6920.7 6934.4 6980.8 6989.4 7013.3 6873.8 6900.8 6963.2 6968.8 6978.4 6930.9 6948.5 6959.0 6980.0 7071.0 6683.7 6703.2 6749.2 6752.2 6752.8 6572.3 6587.6 6617.3 6653.6 6723.7 6856.0 6874.0 6919.3 6924.1 6955.3 5568.8 5583.6 5607.3 5611.2 5626.8 6370.6 6456.2 6684.4 6729.4 6750.7 6503.5 6521.7 6524.7 6530.2 6555.0 6440.3 6466.8 6530.9 6538.0 6548.4 6360.9 6399.7 6491.2 6512.8 6523.2 6526.3 6556.9 6586.2 6592.4 6654.6 6300.8 6345.2 6358.8 6363.2 6407.5 16:15:22 INFO - PID 22950 | 16:15:22 INFO - PID 22950 | [#5] yui.html Cycles:180 Average:27788.81 Median:17550.52 stddev:42898.59 (244.4%) stddev-sans-first:42971.52 16:15:22 INFO - PID 22950 | Values: 927.2 955.8 959.8 967.7 982.3 18647.8 19644.5 19666.9 19702.7 19736.8 16891.8 17683.7 17820.6 17821.3 17828.8 1031.6 1051.2 1052.3 1053.4 1055.4 1004.6 1032.2 1062.8 1066.4 1069.6 1124.4 1127.8 1128.3 1130.8 1132.1 1055.4 1098.2 1127.5 1128.4 1131.2 805.3 810.0 810.5 811.0 811.0 19372.4 19640.0 19645.5 19653.8 19677.4 22468.0 23021.3 23186.9 23245.2 23277.1 17417.3 18334.8 18412.4 18433.9 18507.4 4056.8 4081.5 4092.2 4092.6 4095.5 155846.2 156258.0 156605.0 159161.0 161653.0 17158.1 17233.4 17315.5 17377.6 17869.2 27091.6 27103.6 27109.3 27214.9 30683.8 7632.4 7668.5 7771.3 7791.4 7817.7 4432.1 4494.4 4500.3 4500.5 4504.8 5961.7 6005.2 6018.3 6074.1 6175.4 1000.2 1015.7 1033.4 1033.6 1042.2 691.1 703.3 711.2 713.6 718.9 11890.3 11991.3 12062.6 12253.5 12832.7 703.2 716.1 720.3 729.0 731.1 5624.3 5629.4 5630.5 5720.4 5774.9 145318.0 147197.3 147299.3 151312.2 153463.2 134390.0 136205.0 137423.0 138969.3 143188.0 116583.0 117121.0 118571.0 119355.4 119403.8 10709.7 10816.7 10852.7 10911.1 11121.8 56023.7 56247.0 56851.7 57919.0 59238.0 70346.3 70828.6 72389.6 72549.0 72922.3 16119.0 16502.0 16580.7 16596.8 16599.4 18444.4 18670.4 18861.8 18869.4 18883.1 16053.0 16168.3 16178.8 16286.8 16297.5 15853.2 16188.0 16202.9 16271.4 16326.3 13586.7 13786.7 13805.5 13811.3 13906.1 11500.5 11566.9 11627.8 11873.9 11998.2 11969.7 12143.3 12462.4 12512.4 12592.6 16:15:22 INFO - PID 22950 | -------- Summary: end -------- 16:15:22 INFO - PID 22950 | 16:15:23 INFO - PID 22950 | 16:15:23 INFO - PID 22950 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 16:15:23 INFO - PID 22950 | 16:15:23 INFO - TEST-INFO | 22950: exit 0 16:15:23 INFO - TEST-OK | dromaeo_css | took 1108725ms 16:15:23 INFO - TEST-START | kraken 16:15:23 INFO - Initialising browser for kraken test... 16:15:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58694/getInfo.html -profile /tmp/tmpzO6L_e/profile 16:15:23 INFO - TEST-INFO | started process 23328 (/builds/slave/test/build/application/firefox/firefox http://localhost:58694/getInfo.html) 16:15:29 INFO - TEST-INFO | 23328: exit 0 16:15:29 INFO - Browser initialized. 16:15:29 INFO - Running cycle 1/1 for kraken test... 16:15:29 INFO - Using env: {'DISPLAY': ':0', 16:15:29 INFO - 'HOME': '/home/cltbld', 16:15:29 INFO - 'JSGC_DISABLE_POISONING': '1', 16:15:29 INFO - 'LANG': 'en_US.UTF-8', 16:15:29 INFO - 'LANGUAGE': 'en_US:en', 16:15:29 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:15:29 INFO - 'LOGNAME': 'cltbld', 16:15:29 INFO - 'MAIL': '/var/mail/cltbld', 16:15:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:15:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:15:29 INFO - 'MOZ_CRASHREPORTER': '1', 16:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:29 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:15:29 INFO - 'MOZ_NO_REMOTE': '1', 16:15:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:15:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:29 INFO - 'NO_EM_RESTART': '1', 16:15:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:29 INFO - 'PWD': '/builds/slave/test', 16:15:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:15:29 INFO - 'RUST_BACKTRACE': 'full', 16:15:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:15:29 INFO - 'SHELL': '/bin/bash', 16:15:29 INFO - 'SHLVL': '1', 16:15:29 INFO - 'TERM': 'linux', 16:15:29 INFO - 'TMOUT': '86400', 16:15:29 INFO - 'USER': 'cltbld', 16:15:29 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698', 16:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:29 INFO - '_': '/tools/buildbot/bin/python'} 16:15:29 INFO - TEST-INFO | started process 23566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzO6L_e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:30 INFO - PID 23566 | 16:15:30 INFO - PID 23566 | (/builds/slave/test/build/application/firefox/firefox:23617): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:15:30 INFO - PID 23566 | 16:15:40 INFO - PID 23566 | RSS: Main: 167497728 16:15:40 INFO - PID 23566 | 16:15:43 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58694/tests/kraken/driver.html?testName=audio-beat-detection) 16:15:44 INFO - PID 23566 | RSS: Main: 172879872 16:15:44 INFO - PID 23566 | 16:15:46 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58694/tests/kraken/driver.html?testName=audio-dft) 16:15:47 INFO - PID 23566 | RSS: Main: 172834816 16:15:47 INFO - PID 23566 | 16:15:50 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58694/tests/kraken/driver.html?testName=audio-fft) 16:15:51 INFO - PID 23566 | RSS: Main: 168124416 16:15:51 INFO - PID 23566 | 16:15:53 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58694/tests/kraken/driver.html?testName=audio-oscillator) 16:15:53 INFO - PID 23566 | RSS: Main: 169197568 16:15:53 INFO - PID 23566 | 16:15:55 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58694/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:15:56 INFO - PID 23566 | RSS: Main: 169295872 16:15:56 INFO - PID 23566 | 16:15:59 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58694/tests/kraken/driver.html?testName=imaging-darkroom) 16:16:00 INFO - PID 23566 | RSS: Main: 172654592 16:16:00 INFO - PID 23566 | 16:16:03 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58694/tests/kraken/driver.html?testName=imaging-desaturate) 16:16:04 INFO - PID 23566 | RSS: Main: 172019712 16:16:04 INFO - PID 23566 | 16:16:07 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58694/tests/kraken/driver.html?testName=json-parse-financial) 16:16:07 INFO - PID 23566 | RSS: Main: 171593728 16:16:07 INFO - PID 23566 | 16:16:09 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58694/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:16:09 INFO - PID 23566 | RSS: Main: 171827200 16:16:09 INFO - PID 23566 | 16:16:11 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:16:12 INFO - PID 23566 | RSS: Main: 171999232 16:16:12 INFO - PID 23566 | 16:16:14 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:16:14 INFO - PID 23566 | RSS: Main: 169025536 16:16:14 INFO - PID 23566 | 16:16:17 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:16:17 INFO - PID 23566 | RSS: Main: 168714240 16:16:17 INFO - PID 23566 | 16:16:20 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:16:21 INFO - PID 23566 | RSS: Main: 169975808 16:16:21 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | Cycle 1(1): loaded http://localhost:58694/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58694/tests/kraken/driver.html?testName=ai-astar) 16:16:23 INFO - PID 23566 | RSS: Main: 171479040 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | __start_tp_report 16:16:23 INFO - PID 23566 | _x_x_mozilla_page_load 16:16:23 INFO - PID 23566 | _x_x_mozilla_page_load_details 16:16:23 INFO - PID 23566 | |i|pagename|runs| 16:16:23 INFO - PID 23566 | |0;ai-astar;107;107;106;105;104;108;106;106;105;105 16:16:23 INFO - PID 23566 | |1;audio-beat-detection;113;117;114;115;116;117;112;144;112;138 16:16:23 INFO - PID 23566 | |2;audio-dft;164;164;161;162;162;160;163;162;169;166 16:16:23 INFO - PID 23566 | |3;audio-fft;75;73;72;73;73;73;73;80;73;73 16:16:23 INFO - PID 23566 | |4;audio-oscillator;79;79;78;78;78;78;79;78;78;78 16:16:23 INFO - PID 23566 | |5;imaging-gaussian-blur;110;114;113;113;111;114;110;114;114;115 16:16:23 INFO - PID 23566 | |6;imaging-darkroom;149;152;150;149;150;151;150;150;150;150 16:16:23 INFO - PID 23566 | |7;imaging-desaturate;93;94;94;94;94;94;94;94;94;94 16:16:23 INFO - PID 23566 | |8;json-parse-financial;45;44;44;45;44;45;44;43;44;46 16:16:23 INFO - PID 23566 | |9;json-stringify-tinderbox;37;37;37;36;37;36;37;37;37;37 16:16:23 INFO - PID 23566 | |10;stanford-crypto-aes;76;71;75;76;73;73;71;72;73;70 16:16:23 INFO - PID 23566 | |11;stanford-crypto-ccm;115;104;110;110;116;112;110;112;109;106 16:16:23 INFO - PID 23566 | |12;stanford-crypto-pbkdf2;152;158;152;166;156;154;165;156;153;153 16:16:23 INFO - PID 23566 | |13;stanford-crypto-sha256-iterative;64;62;77;63;61;59;64;61;65;57 16:16:23 INFO - PID 23566 | __end_tp_report 16:16:23 INFO - PID 23566 | __start_cc_report 16:16:23 INFO - PID 23566 | _x_x_mozilla_cycle_collect,902 16:16:23 INFO - PID 23566 | __end_cc_report 16:16:23 INFO - PID 23566 | __startTimestamp1505344583320__endTimestamp 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | ------- Summary: start ------- 16:16:23 INFO - PID 23566 | Number of tests: 14 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | [#0] ai-astar Cycles:10 Average:105.90 Median:106.00 stddev:1.20 (1.1%) stddev-sans-first:1.20 16:16:23 INFO - PID 23566 | Values: 107.0 107.0 106.0 105.0 104.0 108.0 106.0 106.0 105.0 105.0 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | [#1] audio-beat-detection Cycles:10 Average:119.80 Median:116.50 stddev:11.41 (9.8%) stddev-sans-first:11.83 16:16:23 INFO - PID 23566 | Values: 113.0 117.0 114.0 115.0 116.0 117.0 112.0 144.0 112.0 138.0 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:2.63 (1.6%) stddev-sans-first:2.77 16:16:23 INFO - PID 23566 | Values: 164.0 164.0 161.0 162.0 162.0 160.0 163.0 162.0 169.0 166.0 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | [#3] audio-fft Cycles:10 Average:73.80 Median:73.00 stddev:2.30 (3.2%) stddev-sans-first:2.40 16:16:23 INFO - PID 23566 | Values: 75.0 73.0 72.0 73.0 73.0 73.0 73.0 80.0 73.0 73.0 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | [#4] audio-oscillator Cycles:10 Average:78.30 Median:78.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 16:16:23 INFO - PID 23566 | Values: 79.0 79.0 78.0 78.0 78.0 78.0 79.0 78.0 78.0 78.0 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:114.00 stddev:1.81 (1.6%) stddev-sans-first:1.62 16:16:23 INFO - PID 23566 | Values: 110.0 114.0 113.0 113.0 111.0 114.0 110.0 114.0 114.0 115.0 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 16:16:23 INFO - PID 23566 | Values: 149.0 152.0 150.0 149.0 150.0 151.0 150.0 150.0 150.0 150.0 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 16:16:23 INFO - PID 23566 | Values: 93.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | [#8] json-parse-financial Cycles:10 Average:44.40 Median:44.50 stddev:0.84 (1.9%) stddev-sans-first:0.87 16:16:23 INFO - PID 23566 | Values: 45.0 44.0 44.0 45.0 44.0 45.0 44.0 43.0 44.0 46.0 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | [#9] json-stringify-tinderbox Cycles:10 Average:36.80 Median:37.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 16:16:23 INFO - PID 23566 | Values: 37.0 37.0 37.0 36.0 37.0 36.0 37.0 37.0 37.0 37.0 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:73.00 stddev:2.11 (2.9%) stddev-sans-first:1.94 16:16:23 INFO - PID 23566 | Values: 76.0 71.0 75.0 76.0 73.0 73.0 71.0 72.0 73.0 70.0 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | [#11] stanford-crypto-ccm Cycles:10 Average:110.40 Median:111.00 stddev:3.66 (3.3%) stddev-sans-first:3.48 16:16:23 INFO - PID 23566 | Values: 115.0 104.0 110.0 110.0 116.0 112.0 110.0 112.0 109.0 106.0 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:156.00 stddev:5.13 (3.3%) stddev-sans-first:5.17 16:16:23 INFO - PID 23566 | Values: 152.0 158.0 152.0 166.0 156.0 154.0 165.0 156.0 153.0 153.0 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:5.40 (8.5%) stddev-sans-first:5.72 16:16:23 INFO - PID 23566 | Values: 64.0 62.0 77.0 63.0 61.0 59.0 64.0 61.0 65.0 57.0 16:16:23 INFO - PID 23566 | -------- Summary: end -------- 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 16:16:23 INFO - PID 23566 | 16:16:23 INFO - PID 23566 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:16:23 INFO - TEST-INFO | 23566: exit 0 16:16:23 INFO - TEST-OK | kraken | took 60315ms 16:16:23 INFO - SUITE-END | took 1169s 16:16:23 INFO - Completed test suite (00:19:29) 16:16:23 INFO - javascript benchmark 16:16:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8956.818191684433, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3810.5808361080285, 3845.3655146900755, 3854.3447613905632, 3862.690984721223, 3899.0447340401606, 6198.78304259351, 6290.119383286338, 6313.0, 6339.778107766229, 6370.076338930858, 6278.434940855322, 6304.558680892339, 6392.968035159818, 6405.039244113385, 6430.871382572357, 145.33284486021088, 5570.721463926808, 5599.1041433370665, 5623.0, 5644.01229784788, 5507.228987941671, 5521.5306698930635, 5605.803796867111, 5618.550515958714, 5623.80316688916, 5484.478974497416, 5516.586256030773, 5532.640378375393, 5589.329280486348, 5604.663720176803, 5510.283663123809, 5542.75057622408, 5624.3813180550105, 5625.128105143709, 5629.746661400247, 5543.0, 5546.362168350651, 5609.663420194802, 5613.803516876889, 5633.718314084321, 6157.2919114301985, 6192.721327540272, 6192.938070619326, 6264.27960784511, 6291.02489114188, 6662.56693314933, 6774.119364482635, 6790.660466976681, 6863.794086177422, 6876.724931002804, 6931.653417329164, 7025.0, 7046.894296585555, 7053.0830991970715, 7069.787906362817, 6340.175777148987, 6430.7749228776765, 6489.805305840785, 6518.152640156797, 6524.314946930599, 6927.203371612329, 7022.227554968949, 7023.367896889305, 7069.82325441868, 7070.646467676698, 6769.458443324522, 6805.931940680629, 6874.759383421556, 6897.1033765611155, 6902.378785909293, 6642.136522252076, 6749.291324410964, 6883.27725588806, 6920.688569014305, 6991.056207411934, 6326.9683651581445, 6887.483438742014, 6895.655217239118, 6905.585664860125, 6918.688659010357, 6771.932280677229, 6867.965660171767, 6871.175458944958, 6871.9656401717675, 6936.0, 4974.204127339608, 5005.0, 5009.248612708123, 5040.621953353513, 5081.339425874687, 4450.399196108484, 4505.819767209275, 4528.320751887178, 4561.201789686792, 4598.678092533558, 6140.846478838065, 6172.845678858064, 6177.722002509898, 6203.069539569101, 6203.31763506014, 6714.429273511806, 6794.93205067943, 6897.862042759117, 6901.75843845463, 6908.585484870924, 6013.51891848651, 6146.754129834846, 6165.414285642857, 6255.186825712628, 6260.0, 5477.643953143033, 5541.5843811714285, 5542.196381524656, 5545.390007099216, 5554.944450555443, 7035.47233957445, 7036.472264580177, 7091.858162836715, 7118.145822501229, 7127.180374257026, 6721.0, 6834.316568343126, 6837.863242735217, 6888.793336199922, 6915.688794004282, 6974.755883544051, 7030.543014704028, 7100.538464999759, 7110.5022648414115, 7156.463265255023, 6821.488388370793, 6914.654267286515, 6923.9307606923285, 6940.479464040318, 6956.37392634645, 6764.086848275617, 6900.413464855544, 6902.482313826584, 6906.412954898889, 6988.266232045562, 6578.605283682994, 6579.901301480386, 6598.208215014229, 6612.272650008592, 6620.0, 6563.245226798788, 6571.605703657796, 6572.507061970276, 6572.868542629216, 6574.901376479261, 6387.0, 6406.903896441464, 6429.03564465334, 6471.158749362553, 6488.935110649022, 6654.866902661823, 6662.200535935525, 6677.09859169006, 6694.665266736741, 6768.357006084414, 6336.0, 6454.741810327534, 6533.542652014504, 6547.574407663486, 6550.312217217314], "value": 6182.659753045066, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [898.384606544517, 933.4959122074081, 946.077574364994, 978.0415193110751, 983.1053741095602, 41605.0, 42115.57884421155, 42353.0, 42691.14617707648, 42748.78625606871, 39676.40485392721, 39753.20493590127, 39944.80027599865, 40015.199696006064, 40087.0, 7297.890531642016, 7411.444141689368, 7412.221716719748, 7420.925790742104, 7428.442866784986, 7374.631268436584, 7461.477696561243, 7490.176080631126, 7491.6254187290415, 7498.925010749877, 7907.486013409139, 8091.19088091192, 8092.473989190713, 8104.351651867836, 8105.594720263993, 8014.7194848180325, 8042.517448953023, 8054.677812887478, 8088.716894908679, 8090.595470226494, 7939.206079392073, 7944.801379965489, 8016.35869130474, 8040.115587285394, 8048.919510804875, 39329.0, 39661.00847478836, 39675.20649586992, 39684.60315396838, 39750.20499589992, 3301.422251106047, 3356.6139893912023, 3360.2439451123546, 3360.815155166465, 3367.9158021049425, 33143.83428082868, 33181.3363732724, 33296.0, 33328.1667958303, 33374.165645858804, 5409.161579955074, 5427.701476418795, 5453.509184173404, 5462.426445223234, 5494.615376923617, 209550.0, 210815.0, 210962.0, 211310.0, 211668.0, 50806.491935080914, 50957.74521127371, 51064.0, 51203.487965120614, 51890.48109518857, 54354.45645543573, 54537.45462545324, 54554.0, 54584.181237281475, 54633.0, 16611.335546578244, 16739.748903766453, 16746.1626918656, 16751.581210469834, 16761.832381676028, 13485.190888546718, 13498.865011349957, 13501.83970564705, 13504.864951350557, 13562.321883905764, 14772.0, 14782.556523304318, 14808.777868331983, 14851.628709282355, 14924.477643282433, 5715.571332150105, 5748.166515855178, 5836.023627949691, 5860.00379935412, 5922.437368450077, 1089.1722291058852, 1098.5880294889416, 1099.1591432554103, 1107.5735841700841, 1114.7714718482691, 24787.25638230856, 25229.369265768135, 25255.87372063128, 25281.0, 25345.49309013846, 1191.0531127753457, 1191.6127258640977, 1193.4450480526598, 1201.8798120188087, 1226.0926914083514, 12972.729772289811, 13340.799888001688, 13397.26315052662, 13408.396622152026, 13412.597622071353, 290118.0, 291143.0, 291622.0, 293682.0, 294499.0, 56135.0, 57998.0, 62207.37792622107, 62287.0, 62490.0, 1498.6328349554428, 1514.6516301250774, 1516.6814968856443, 1520.8783297336186, 1522.528016314946, 30122.849385752932, 30221.69778302189, 30376.0, 30450.695493044786, 30531.084067478012, 40582.39126413165, 40992.79503602463, 41078.58921410747, 41117.383239252034, 41195.58804411918, 251801.0, 252597.0, 252723.0, 252829.0, 253289.0, 35977.64022359848, 36015.27969440544, 36199.63800362068, 36224.456633149995, 36451.27097458089, 44615.55384446244, 46828.0, 46898.53101468942, 46957.06085878332, 47061.0, 33695.15762105967, 33803.98588042363, 34059.0, 34292.82853585716, 34425.31149377049, 33577.83211083929, 33730.49404258889, 33813.66186338105, 34331.31337373288, 34356.312873742885, 39284.0, 39292.60707393004, 39332.410013850385, 39380.606193937696, 39460.60539394569, 32701.836490817393, 33210.667893321726, 33317.333653326314, 33431.49852752259, 33531.497027544116, 24567.508649826545, 25265.368365791, 25283.494330113663, 25380.365490862878, 25694.229173124837], "value": 18338.159734105855, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.6708820345511, 590.852286928268, 592.1473078766574, 593.4273426143772, 604.9992039484158, 22809.0, 23695.881520592393, 23733.881330593365, 23737.406564835866, 23744.931478083483, 24486.387840304, 25770.484590308184, 27106.32234194146, 27110.5933410999, 27160.86419567904, 6528.249251336086, 6561.573497722657, 6611.603303801763, 6637.634930078843, 6641.601503909781, 6491.967540162316, 6522.445592124675, 6580.638064906429, 6761.323867613249, 6787.898181527281, 6748.898766518481, 6760.695768690396, 6762.864742705143, 6763.5941843489545, 6769.661516924159, 6767.289434609344, 6767.796966091, 6774.695138718745, 6776.525643205002, 6782.016607591921, 6301.464375528086, 6312.400321969406, 6330.272018717815, 6335.429811317003, 6346.682665866734, 29834.701652983626, 30361.69638303611, 30831.537526937114, 31471.213219669462, 31662.208444788834, 2271.216430331533, 2294.8508346957396, 2296.2537175418056, 2296.9310920672406, 2298.712660917385, 20452.0, 21091.8945405272, 21136.365909022756, 22057.889710551506, 22061.889690551605, 2512.208654273898, 2522.14247155966, 2536.518061568296, 2591.2485379239997, 2609.856457894815, 131242.0, 135557.3222133893, 158305.0, 166169.0, 166323.0, 15203.818949788896, 15773.369065237492, 15864.92067539678, 16384.672306553803, 17832.732509012374, 25805.870970645403, 25812.934965202738, 25874.35314117162, 25937.351566210997, 25947.351316217246, 9666.0, 9816.460094694718, 9875.259355548362, 10011.249156313306, 10049.447280399649, 8756.430831996027, 8833.60248788806, 8868.379213454997, 8909.198172164537, 8910.420822646507, 9217.170454659114, 9628.0, 9672.0, 9753.65862194834, 10023.34848234877, 2709.1330774152475, 2723.496153211662, 2726.2601085908536, 2825.110090321542, 2864.957025644617, 1030.2685093583639, 1044.639599338227, 1046.5970601318547, 1047.638564695179, 1058.090042563395, 21069.683954740693, 21128.049237784337, 21149.25977590777, 21376.786232137478, 21647.67528487074, 1083.3337497439177, 1099.9560017599206, 1105.3202280597375, 1107.180686292138, 1109.9278546894427, 11814.409279536161, 11861.0, 11929.22460040112, 11936.164468487295, 12121.454534545966, 597806.0, 598494.0, 613530.0, 628880.0, 638754.0, 121837.39081304714, 122515.0, 124040.0, 124662.37668811779, 128211.35894320469, 1098.357460885391, 1144.3934714601276, 1215.7629262293767, 1234.0682784497646, 1281.1416351044822, 22190.334289971328, 22782.20262290812, 22901.427464313525, 22921.541569168858, 22960.54078918379, 62539.0, 63203.6839815798, 64055.35944640494, 64392.0, 64516.67741661262, 79810.60094699722, 79926.20073799188, 80371.0, 80739.0, 81044.0, 15287.847121529087, 15827.52517424479, 15830.129342886252, 15848.683026339178, 15849.049057056614, 23159.6526052106, 23393.181238657246, 24829.130980415597, 25044.74955250497, 25199.496010080064, 19912.203511859363, 19925.302614408425, 20047.599048018667, 20057.197712091936, 20251.0, 17642.470725878244, 17762.37831675885, 17847.196876140344, 17878.106094695475, 18132.818671813115, 20268.89865550663, 20531.0, 20642.0, 20672.069756860677, 20672.689909651068, 15473.767893481381, 15517.689646207238, 15541.37834486653, 15546.611334716723, 15553.611159721098, 19471.123799429344, 19723.112459939624, 19756.60486790285, 19764.40706778799, 19768.90115549413], "value": 12797.363368938364, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.6448755567333, 1457.613732360924, 1459.83211930628, 1474.498670452046, 1483.7403454395478, 16772.83227167728, 17461.3015479381, 17484.737728934077, 17492.12539373031, 17506.212220450077, 16717.414890478834, 16802.15989200538, 16816.0, 16825.242864071115, 16825.99999999997, 2874.6694130174983, 2878.150945471091, 2928.88284468621, 2930.238138084103, 2930.912072637824, 2770.279727270914, 2831.6602007759097, 2840.2899275181203, 2842.147355793264, 2849.7720182385465, 2588.741125887415, 2718.130198336533, 2798.468291024709, 2821.4216085702483, 2829.2643912582776, 2845.430913817245, 2882.4235152969386, 2916.533354663254, 2917.606123173387, 2919.357741296911, 2579.8968041278326, 2753.931151721223, 2762.0, 2807.73326533981, 2824.830510169376, 16689.415870444598, 16767.496975090766, 16859.494215173563, 16890.577735556588, 16896.915515422344, 8284.130166332568, 8473.491590504527, 8499.235068843773, 8604.827903441896, 8622.137786221328, 5321.281626980347, 5441.972790136024, 5552.694601796899, 5683.437054809919, 5694.288213973254, 2058.711780350752, 2067.917283308666, 2108.156737305075, 2124.5538436928264, 2156.3207589609224, 30211.69788302111, 30347.0, 30618.0, 30663.38673226523, 30695.38609227825, 7216.061911951518, 7260.346568808833, 7342.743003994835, 7522.398208143335, 7547.735829246059, 19969.101390437467, 19987.20051197965, 20001.899990499955, 20005.099770510362, 20008.0, 8512.957435212784, 8713.695020674246, 8720.825583488422, 8744.387892847439, 8747.606357713918, 7626.351760100453, 7728.227177282227, 7749.961250193713, 7754.689812407553, 7774.416918731004, 5795.565332600072, 5903.114532820111, 6013.398660133952, 6068.120122582289, 6069.726862291208, 1861.4415675297357, 1890.1966664167674, 1890.5611760828378, 1922.3848368522217, 1935.0421541337128, 967.8209531236744, 982.8230918434607, 983.1692220074169, 985.2905907746411, 1011.6004178349658, 8557.78605534854, 8647.264982476434, 8666.696665616673, 8758.781030474162, 8768.123187681182, 776.6621519638975, 782.8003859015914, 785.4109417936547, 794.8608993426127, 800.0599295827379, 4833.154198015333, 4969.577585905166, 4981.526754958273, 5921.822345329647, 6042.879142417215, 23598.17406390768, 23718.644220336708, 24681.62977555302, 24783.87608061948, 24804.627930581057, 23614.0, 23985.400364991016, 24487.142949996665, 24615.0, 24677.0, 12045.0, 12205.084618653636, 12345.753084938251, 12358.567450139382, 12362.567310144103, 8992.685256016008, 9019.143181397756, 9031.593578288861, 9060.411073280216, 9080.954595226982, 20431.0, 20558.486037849172, 20701.378958631267, 21194.894025529775, 21310.0, 21156.153753849674, 21487.677684835053, 21631.35105946824, 21671.458213544156, 21749.673754893374, 13336.799948000593, 13465.39405726725, 13468.865311347154, 13477.0, 13486.190828550318, 14809.111453312837, 14906.925465373037, 14921.701565968402, 15110.697786044437, 15136.167510787012, 12148.75702485963, 12148.817767733315, 12297.200681955645, 12529.37353132358, 12582.748345033231, 11709.824352634887, 11822.645320640395, 12025.579104731292, 12168.756624867276, 12444.253344798979, 10839.187060970302, 11063.50214240345, 11065.446727663424, 11076.169287303323, 11086.667399978014, 8305.626246818787, 8337.374696897878, 8365.581720914051, 8386.161383861809, 8511.106333834858, 7826.178251283533, 7894.644740986554, 7957.846112313798, 7976.641051152828, 8101.594920253846], "value": 7265.971358510138, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.2746919128368, 545.5117669685629, 565.9009673307171, 578.7222133375976, 579.2556564814212, 6099.268087829461, 6153.2923713772925, 6278.9372106278925, 6306.558540902127, 6317.399847014538, 6010.188624535686, 6153.323134455218, 6223.595466294688, 6251.562390632646, 6279.466245369149, 4801.207800712878, 5052.797888084481, 5056.721880296583, 5078.619103567247, 5082.491750824925, 4859.684120532172, 4896.1186986342445, 4911.82808601699, 4913.803447862099, 4918.557329840313, 4860.270959356108, 4882.633802464811, 4921.729304888229, 4935.235038569028, 4963.45402005779, 4886.828960986366, 4902.65681402302, 4904.656674032819, 4940.456549779521, 4947.307376967227, 4489.618382437497, 4496.752678602676, 4505.977470112662, 4511.932321015187, 4513.300438432048, 6061.121137435047, 6147.170132032164, 6153.446189842891, 6218.502519798405, 6227.283862355796, 5845.415458454163, 5862.824115276549, 5866.794662186803, 5870.735816888207, 5891.941080589182, 6588.538802283842, 6657.833554161136, 6667.699953502104, 6681.231658359302, 6701.396874281338, 5008.62435317349, 5052.115879721071, 5058.3443692061965, 5065.822696205652, 5070.0, 6808.3191680832015, 6938.653067346612, 6963.16442026955, 6981.650917454158, 7036.437085033185, 5058.873528161752, 5065.164247899129, 5081.136206844845, 5110.770015349318, 5121.74391280442, 5159.787449949259, 5179.792808287626, 5184.222366645034, 5198.090334191501, 5199.1266506452175, 5748.425157484218, 5759.6832174229985, 5759.85600359986, 5784.768609255667, 5808.303003639506, 6318.0, 6416.454601358843, 6576.473882089422, 6598.439132673777, 6619.172603424572, 1959.7844237133904, 1960.735300734411, 1968.252064215589, 1968.3406058970406, 1981.5937732764748, 1463.2318033032743, 1487.5091219897408, 1490.5304828978838, 1498.6028702393874, 1505.4268289637355, 6016.69916504173, 6062.363451837494, 6085.452309292096, 6098.207233059674, 6130.478909292671, 6639.468842492589, 6675.9332406676285, 6722.226943901514, 6722.798316050526, 6727.159105111861, 6036.5170786336985, 6059.818205453756, 6074.210352654127, 6077.20996270482, 6098.1157732128595, 3485.5360748485696, 3520.383932811748, 3546.893593192157, 3559.2169722660974, 3586.318599466093, 6920.653967301615, 6934.410575101072, 6980.825479362955, 6989.37095661393, 7013.26360732126, 6873.759418420332, 6900.827479313058, 6963.199232088375, 6968.7804634188815, 6978.371946524837, 6930.8613827724175, 6948.478864085113, 6959.0, 6979.987901754319, 7070.984769340713, 6683.732650693918, 6703.195616526048, 6749.190097188369, 6752.223494298022, 6752.831179220559, 6572.277049524453, 6587.604743715392, 6617.338266173344, 6653.567518111501, 6723.731050757915, 6856.0, 6873.965630172017, 6919.273476284918, 6924.134483189601, 6955.304469553004, 5568.777248909998, 5583.637063590853, 5607.271054762855, 5611.158326251095, 5626.831195064155, 6370.58591191571, 6456.225252969673, 6684.364985326386, 6729.394354508117, 6750.683616694698, 6503.496153980657, 6521.7065232065615, 6524.706388212637, 6530.216374035146, 6555.000724778988, 6440.29156792743, 6466.838329041811, 6530.869382612416, 6538.0, 6548.410643042149, 6360.936390636034, 6399.6800159992745, 6491.188601424822, 6512.837179070561, 6523.18460192476, 6526.282108968105, 6556.934969986847, 6586.176727909012, 6592.43964263043, 6654.633995130121, 6300.842478938063, 6345.206849143857, 6358.841028974312, 6363.172787537591, 6407.487401007815], "value": 5187.439306360151, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [927.1933417926405, 955.8375076237039, 959.7648576098861, 967.6516454076532, 982.3172894838088, 18647.813521864777, 19644.508887277807, 19666.90166549167, 19702.704459433084, 19736.802631973675, 16891.83108168918, 17683.734743978817, 17820.64358712825, 17821.287148514075, 17828.82171178288, 1031.577053408101, 1051.1538211739546, 1052.3212527919488, 1053.3627155570846, 1055.3773273768475, 1004.5730564510054, 1032.1742605915238, 1062.8352605346183, 1066.3548553125363, 1069.6470164845582, 1124.432161758315, 1127.8421021057059, 1128.3004537186955, 1130.773845230953, 1132.0717012050081, 1055.4036969112426, 1098.1763677242068, 1127.5320741892106, 1128.3568366031325, 1131.1516362727955, 805.3476683886071, 809.9716509922124, 810.4812919731377, 810.9959450202712, 811.0227176252602, 19372.4188274352, 19640.01799910013, 19645.508862278413, 19653.803461965483, 19677.409677709693, 22468.0, 23021.309360719206, 23186.884065579732, 23245.186418475274, 23277.06891724329, 17417.30330786767, 18334.816651833444, 18412.447626571226, 18433.90783046076, 18507.35224267144, 4056.776877271749, 4081.5306239782212, 4092.202020605983, 4092.5702801205744, 4095.52901416335, 155846.22076889657, 156258.0, 156605.0, 159161.0, 161653.0, 17158.142092895556, 17233.39683111085, 17315.480535583953, 17377.56556086083, 17869.195886185153, 27091.593626095626, 27103.593446098323, 27109.32226694309, 27214.911403544033, 30683.8465807674, 7632.389408847279, 7668.463207575416, 7771.300582947561, 7791.4156438267355, 7817.726379576688, 4432.13573353193, 4494.415725955605, 4500.302453119772, 4500.482444518857, 4504.752238626841, 5961.718230580359, 6005.219321488266, 6018.277806663228, 6074.149619053248, 6175.413335733098, 1000.2498126405196, 1015.6749840051112, 1033.426448321174, 1033.612395351743, 1042.2391654092555, 691.1188235000415, 703.2791388826494, 711.1643818513227, 713.5540287320425, 718.9137303523611, 11890.28658280506, 11991.340476273714, 12062.638120856212, 12253.509859605516, 12832.679183020498, 703.2299631903059, 716.0726858717973, 720.3372896934833, 728.9635518224068, 731.1445608637906, 5624.29696287964, 5629.437056294338, 5630.5214056805635, 5720.370759216483, 5774.913376299359, 145318.0, 147197.2640136814, 147299.2635036818, 151312.2434387821, 153463.23268383587, 134390.0, 136205.0, 137423.0, 138969.30515347357, 143188.0, 116583.0, 117121.0, 118571.0, 119355.40322298332, 119403.820866271, 10709.678709638723, 10816.67549973502, 10852.67441976742, 10911.072558832588, 11121.83317250258, 56023.719881401965, 56247.0, 56851.71574142103, 57919.0, 59238.0, 70346.29653703602, 70828.64585677245, 72389.63805180941, 72549.0, 72922.27077729155, 16119.0, 16502.0, 16580.668386632442, 16596.75104873452, 16599.41902033423, 18444.446666600023, 18670.43988680342, 18861.811381886004, 18869.43391698251, 18883.05584720786, 16053.0, 16168.272427740545, 16178.838211617733, 16286.755698664292, 16297.511074667778, 15853.207339633203, 16188.0, 16202.91898540547, 16271.430499932445, 16326.265318060478, 13586.728265434438, 13786.724265514835, 13805.51680691171, 13811.309434528433, 13906.096103753223, 11500.48247828833, 11566.901144391606, 11627.767444651228, 11873.940630296793, 11998.160128790902, 11969.74843647004, 12143.332116733665, 12462.43919023628, 12512.37438128108, 12592.622221333375], "value": 9440.561325385992, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1382.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 106.0, 105.0, 104.0, 108.0, 106.0, 106.0, 105.0, 105.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 114.0, 115.0, 116.0, 117.0, 112.0, 144.0, 112.0, 138.0], "value": 119.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 161.0, 162.0, 162.0, 160.0, 163.0, 162.0, 169.0, 166.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 72.0, 73.0, 73.0, 73.0, 73.0, 80.0, 73.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 78.0, 78.0, 79.0, 78.0, 78.0, 78.0], "value": 78.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 113.0, 113.0, 111.0, 114.0, 110.0, 114.0, 114.0, 115.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 150.0, 149.0, 150.0, 151.0, 150.0, 150.0, 150.0, 150.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 44.0, 44.0, 45.0, 44.0, 45.0, 44.0, 43.0, 44.0, 46.0], "value": 44.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 36.0, 37.0, 36.0, 37.0, 37.0, 37.0, 37.0], "value": 36.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 71.0, 75.0, 76.0, 73.0, 73.0, 71.0, 72.0, 73.0, 70.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 104.0, 110.0, 110.0, 116.0, 112.0, 110.0, 112.0, 109.0, 106.0], "value": 110.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 158.0, 152.0, 166.0, 156.0, 154.0, 165.0, 156.0, 153.0, 153.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 77.0, 63.0, 61.0, 59.0, 64.0, 61.0, 65.0, 57.0], "value": 63.3, "unit": "score"}]}]} 16:16:24 INFO - Return code: 0 16:16:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:16:24 INFO - # TBPL SUCCESS # 16:16:24 INFO - Running post-action listener: _package_coverage_data 16:16:24 INFO - Running post-action listener: _resource_record_post_action 16:16:24 INFO - [mozharness: 2017-09-13 23:16:24.119631Z] Finished run-tests step (success) 16:16:24 INFO - Running post-run listener: _resource_record_post_run 16:16:24 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 335069184; Read time: 8; Write time: 207204 16:16:24 INFO - TinderboxPrint: CPU usage
13.1% 16:16:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:16:24 INFO - TinderboxPrint: I/O write bytes / time
335,069,184 / 207,204 16:16:24 INFO - TinderboxPrint: CPU idle
8,226.3 (86.9%) 16:16:24 INFO - TinderboxPrint: CPU user
1,188.0 (12.5%) 16:16:24 INFO - TinderboxPrint: Swap in / out
0 / 0 16:16:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9576448; Read time: 0; Write time: 1116 16:16:24 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:16:24 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 324878336; Read time: 8; Write time: 206084 16:16:24 INFO - Running post-run listener: _upload_blobber_files 16:16:24 INFO - Blob upload gear active. 16:16:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:16:24 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 16:16:24 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'] 16:16:24 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 16:16:25 INFO - (blobuploader) - INFO - Open directory for files ... 16:16:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:16:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:16:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:26 INFO - (blobuploader) - INFO - Done attempting. 16:16:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:16:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:16:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:27 INFO - (blobuploader) - INFO - Done attempting. 16:16:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:16:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:16:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:34 INFO - (blobuploader) - INFO - Done attempting. 16:16:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:16:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:16:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:34 INFO - (blobuploader) - INFO - Done attempting. 16:16:34 INFO - (blobuploader) - INFO - Iteration through files over. 16:16:35 INFO - Return code: 0 16:16:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:16:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:16:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/574e106c2fffcb1f0c66f1cae7389332ede674a41412893feb269e69ccdb665a0ee0fc3ff94e8372e1f172903f7295da0ad4b4bf30dcae07304d88b7712e7f33", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70caefc5074d1a20fb6d121d69adda83b106d3b5101e455dbe2ec5ce4b4ae5a40971053d64f8db8cb41b5364b164db5e4524c92682454dc7b72f442909f6526d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e27a33c2bb9a82ac2d0e70b8aceb10cfca3f10fab7522ebf7c39deee6bdd769b0515c5a5227e7b7f678d1d6d76aa23087c622b2e4420bede88c3a930c443567", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13dfafb29906506ab507c46e7a8ba4ca0ba20bb5846b8aff3ad269d07cfeb74de2dd3cb4d6bd67e4ffd48994fcd2d05e0702b1316d78652b1cc9429025c649a5"} 16:16:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:16:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:16:35 INFO - Contents: 16:16:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/574e106c2fffcb1f0c66f1cae7389332ede674a41412893feb269e69ccdb665a0ee0fc3ff94e8372e1f172903f7295da0ad4b4bf30dcae07304d88b7712e7f33", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70caefc5074d1a20fb6d121d69adda83b106d3b5101e455dbe2ec5ce4b4ae5a40971053d64f8db8cb41b5364b164db5e4524c92682454dc7b72f442909f6526d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e27a33c2bb9a82ac2d0e70b8aceb10cfca3f10fab7522ebf7c39deee6bdd769b0515c5a5227e7b7f678d1d6d76aa23087c622b2e4420bede88c3a930c443567", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13dfafb29906506ab507c46e7a8ba4ca0ba20bb5846b8aff3ad269d07cfeb74de2dd3cb4d6bd67e4ffd48994fcd2d05e0702b1316d78652b1cc9429025c649a5"} 16:16:35 INFO - Running post-run listener: copy_logs_to_upload_dir 16:16:35 INFO - Copying logs to upload dir... 16:16:35 INFO - mkdir: /builds/slave/test/build/upload/logs 16:16:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.275797 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-13 16:16:35.055772) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 16:16:35.059533) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/574e106c2fffcb1f0c66f1cae7389332ede674a41412893feb269e69ccdb665a0ee0fc3ff94e8372e1f172903f7295da0ad4b4bf30dcae07304d88b7712e7f33", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70caefc5074d1a20fb6d121d69adda83b106d3b5101e455dbe2ec5ce4b4ae5a40971053d64f8db8cb41b5364b164db5e4524c92682454dc7b72f442909f6526d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e27a33c2bb9a82ac2d0e70b8aceb10cfca3f10fab7522ebf7c39deee6bdd769b0515c5a5227e7b7f678d1d6d76aa23087c622b2e4420bede88c3a930c443567", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13dfafb29906506ab507c46e7a8ba4ca0ba20bb5846b8aff3ad269d07cfeb74de2dd3cb4d6bd67e4ffd48994fcd2d05e0702b1316d78652b1cc9429025c649a5"} build_url:https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011443 build_url: 'https://queue.taskcluster.net/v1/task/QM8-JeQ6TpyhR0ExuuU8YA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/574e106c2fffcb1f0c66f1cae7389332ede674a41412893feb269e69ccdb665a0ee0fc3ff94e8372e1f172903f7295da0ad4b4bf30dcae07304d88b7712e7f33", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70caefc5074d1a20fb6d121d69adda83b106d3b5101e455dbe2ec5ce4b4ae5a40971053d64f8db8cb41b5364b164db5e4524c92682454dc7b72f442909f6526d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e27a33c2bb9a82ac2d0e70b8aceb10cfca3f10fab7522ebf7c39deee6bdd769b0515c5a5227e7b7f678d1d6d76aa23087c622b2e4420bede88c3a930c443567", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13dfafb29906506ab507c46e7a8ba4ca0ba20bb5846b8aff3ad269d07cfeb74de2dd3cb4d6bd67e4ffd48994fcd2d05e0702b1316d78652b1cc9429025c649a5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 16:16:35.087794) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 16:16:35.088150) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1505343357.409483-572080698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 16:16:35.172129) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 16:16:35.172435) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 16:16:35.172742) ========= ========= Total master_lag: 0.20 =========