builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1505213795.11 results: success (0) revision: 175f1366daee80cde53386a4627402ed3af4c038 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 03:56:35.112293) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 03:56:35.112771) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 03:56:35.113051) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 03:56:35.162049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:56:35.162332) ========= 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=930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-12 03:56:35-- 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% 41.1M=0s 2017-09-12 03:56:35 (41.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159576 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:56:35.340530) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:56:35.340838) ========= 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=930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022362 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:56:35.390863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-12 03:56:35.391174) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 175f1366daee80cde53386a4627402ed3af4c038 --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 175f1366daee80cde53386a4627402ed3af4c038 --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=930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-12 03:56:35,442 truncating revision to first 12 chars 2017-09-12 03:56:35,442 Setting DEBUG logging. 2017-09-12 03:56:35,442 attempt 1/10 2017-09-12 03:56:35,442 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/175f1366daee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-12 03:56:36,236 unpacking tar archive at: mozilla-central-175f1366daee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.095904 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-12 03:56:36.504829) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 03:56:36.505319) ========= script_repo_revision: 175f1366daee80cde53386a4627402ed3af4c038 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 03:56:36.505948) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 03:56:36.506405) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 03:56:36.530213) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-12 03:56:36.530676) ========= /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=930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:56:36 INFO - MultiFileLogger online at 20170912 03:56:36 in /builds/slave/test 03:56:36 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 03:56:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:56:36 INFO - {'append_to_log': False, 03:56:36 INFO - 'base_work_dir': '/builds/slave/test', 03:56:36 INFO - 'blob_upload_branch': 'Firefox', 03:56:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:56:36 INFO - 'branch': 'Firefox', 03:56:36 INFO - 'buildbot_json_path': 'buildprops.json', 03:56:36 INFO - 'code_coverage': False, 03:56:36 INFO - 'config_files': ('talos/linux_config.py',), 03:56:36 INFO - 'default_actions': ('clobber', 03:56:36 INFO - 'read-buildbot-config', 03:56:36 INFO - 'download-and-extract', 03:56:36 INFO - 'populate-webroot', 03:56:36 INFO - 'create-virtualenv', 03:56:36 INFO - 'install', 03:56:36 INFO - 'setup-mitmproxy', 03:56:36 INFO - 'run-tests'), 03:56:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:56:36 INFO - 'disable_ccov_upload': False, 03:56:36 INFO - 'disable_stylo': False, 03:56:36 INFO - 'download_minidump_stackwalk': True, 03:56:36 INFO - 'download_symbols': 'ondemand', 03:56:36 INFO - 'enable_stylo': False, 03:56:36 INFO - 'enable_webrender': False, 03:56:36 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:56:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:56:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:56:36 INFO - 'gecko_profile': False, 03:56:36 INFO - 'gecko_profile_interval': 0, 03:56:36 INFO - 'installer_path': 'installer.exe', 03:56:36 INFO - 'log_level': 'info', 03:56:36 INFO - 'log_name': 'talos', 03:56:36 INFO - 'log_to_console': True, 03:56:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:56:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:56:36 INFO - 'opt_config_files': (), 03:56:36 INFO - 'pip_index': False, 03:56:36 INFO - 'suite': 'dromaeojs-e10s', 03:56:36 INFO - 'system_bits': '32', 03:56:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:56:36 INFO - 'title': 'talos-linux64-ix-022', 03:56:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:56:36 INFO - 'use_talos_json': True, 03:56:36 INFO - 'verify': 'False', 03:56:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:56:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:56:36 INFO - 'work_dir': 'build'} 03:56:36 INFO - [mozharness: 2017-09-12 10:56:36.729431Z] Running clobber step. 03:56:36 INFO - Running pre-action listener: _resource_record_pre_action 03:56:36 INFO - Running main action method: clobber 03:56:36 INFO - rmtree: /builds/slave/test/build 03:56:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:56:37 INFO - Running post-action listener: _resource_record_post_action 03:56:37 INFO - [mozharness: 2017-09-12 10:56:37.736178Z] Finished clobber step (success) 03:56:37 INFO - [mozharness: 2017-09-12 10:56:37.736275Z] Running read-buildbot-config step. 03:56:37 INFO - Running pre-action listener: _resource_record_pre_action 03:56:37 INFO - Running main action method: read_buildbot_config 03:56:37 INFO - Using buildbot properties: 03:56:37 INFO - { 03:56:37 INFO - "project": "", 03:56:37 INFO - "product": "firefox", 03:56:37 INFO - "who": "archaeopteryx@coole-files.de", 03:56:37 INFO - "installer_path": "public/build/target.tar.bz2", 03:56:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:56:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:56:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:56:37 INFO - "stage_platform": "linux64-pgo", 03:56:37 INFO - "basedir": "/builds/slave/test", 03:56:37 INFO - "buildnumber": 179, 03:56:37 INFO - "platform": "ubuntu64_hw", 03:56:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:56:37 INFO - "slavebuilddir": "test", 03:56:37 INFO - "taskId": "ABRxWYfKTWC0bZBoi9oeCQ", 03:56:37 INFO - "branch": "mozilla-central", 03:56:37 INFO - "script_repo_revision": "production", 03:56:37 INFO - "revision": "175f1366daee80cde53386a4627402ed3af4c038", 03:56:37 INFO - "slavename": "talos-linux64-ix-022", 03:56:37 INFO - "repo_path": "mozilla-central" 03:56:37 INFO - } 03:56:37 INFO - Finding installer, test and symbols from parent task. 03:56:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ABRxWYfKTWC0bZBoi9oeCQ'}, attempt #1 03:56:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ABRxWYfKTWC0bZBoi9oeCQ'}, attempt #1 03:56:38 INFO - Task dependencies: ZYGHapDoTCuRA26NgxMAoA 03:56:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA'}, attempt #1 03:56:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.tar.bz2 03:56:39 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.test_packages.json 03:56:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.crashreporter-symbols.zip 03:56:39 INFO - Running post-action listener: _resource_record_post_action 03:56:39 INFO - [mozharness: 2017-09-12 10:56:39.131986Z] Finished read-buildbot-config step (success) 03:56:39 INFO - [mozharness: 2017-09-12 10:56:39.132204Z] Running download-and-extract step. 03:56:39 INFO - Running pre-action listener: _resource_record_pre_action 03:56:39 INFO - Running main action method: download_and_extract 03:56:39 INFO - mkdir: /builds/slave/test/build/tests 03:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:39 INFO - trying https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.test_packages.json 03:56:39 INFO - Downloading https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:56:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:56:39 INFO - Downloaded 989 bytes. 03:56:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:56:39 INFO - Using the following test package requirements: 03:56:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:56:39 INFO - u'common': [u'target.common.tests.zip'], 03:56:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:56:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:56:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:56:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:56:39 INFO - u'mozbase': [u'target.common.tests.zip'], 03:56:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:56:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:56:39 INFO - u'web-platform': [u'target.common.tests.zip', 03:56:39 INFO - u'target.web-platform.tests.tar.gz'], 03:56:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:56:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:56:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.common.tests.zip 03:56:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:56:39 INFO - Fetch https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.common.tests.zip into memory 03:56:40 INFO - Content-Length response header: 55713048 03:56:40 INFO - Bytes received: 55713048 03:56:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.talos.tests.zip 03:56:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:56:51 INFO - Fetch https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.talos.tests.zip into memory 03:56:52 INFO - Content-Length response header: 14499231 03:56:52 INFO - Bytes received: 14499231 03:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:53 INFO - trying https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.tar.bz2 03:56:53 INFO - Downloading https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:56:55 INFO - Downloaded 63582705 bytes. 03:56:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.tar.bz2 03:56:55 INFO - mkdir: /builds/slave/test/properties 03:56:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:56:55 INFO - Writing to file /builds/slave/test/properties/build_url 03:56:55 INFO - Contents: 03:56:55 INFO - build_url:https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.tar.bz2 03:56:55 INFO - Running post-action listener: _resource_record_post_action 03:56:55 INFO - Running post-action listener: find_tests_for_verification 03:56:55 INFO - Running post-action listener: set_extra_try_arguments 03:56:55 INFO - [mozharness: 2017-09-12 10:56:55.403176Z] Finished download-and-extract step (success) 03:56:55 INFO - [mozharness: 2017-09-12 10:56:55.403328Z] Running populate-webroot step. 03:56:55 INFO - Running pre-action listener: _resource_record_pre_action 03:56:55 INFO - Running main action method: populate_webroot 03:56:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:56:55 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:56:55 INFO - 'tests': ['tresize', 03:56:55 INFO - 'tcanvasmark']}, 03:56:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:56:55 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:56:55 INFO - 'tests': ['dromaeo_css', 03:56:55 INFO - 'kraken']}, 03:56:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:56:55 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:56:55 INFO - 'talos_options': ['--disable-stylo'], 03:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:56:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:56:55 INFO - 'tests': ['damp', 'tps']}, 03:56:55 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:56:55 INFO - 'talos_options': ['--disable-stylo'], 03:56:55 INFO - 'tests': ['damp', 'tps']}, 03:56:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:56:55 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:56:55 INFO - 'tests': ['dromaeo_dom']}, 03:56:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:56:55 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:56:55 INFO - 'tests': ['basic_compositor_video', 03:56:55 INFO - 'glvideo']}, 03:56:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:56:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:56:55 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:56:55 INFO - 'talos_options': ['--disable-stylo'], 03:56:55 INFO - 'tests': ['ts_paint_webext', 03:56:55 INFO - 'tp5o_webext']}, 03:56:55 INFO - 'other-e10s': {'tests': ['a11yr', 03:56:55 INFO - 'ts_paint', 03:56:55 INFO - 'tpaint', 03:56:55 INFO - 'sessionrestore', 03:56:55 INFO - 'sessionrestore_many_windows', 03:56:55 INFO - 'sessionrestore_no_auto_restore', 03:56:55 INFO - 'tabpaint']}, 03:56:55 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:56:55 INFO - 'tests': ['a11yr', 03:56:55 INFO - 'ts_paint', 03:56:55 INFO - 'tpaint', 03:56:55 INFO - 'sessionrestore', 03:56:55 INFO - 'sessionrestore_many_windows', 03:56:55 INFO - 'sessionrestore_no_auto_restore', 03:56:55 INFO - 'tabpaint']}, 03:56:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:56:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:56:55 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:56:55 INFO - 'tests': ['bloom_basic_singleton']}, 03:56:55 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:56:55 INFO - 'tests': ['bloom_basic']}, 03:56:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:56:55 INFO - 'tsvgr_opacity', 03:56:55 INFO - 'tart', 03:56:55 INFO - 'tscrollx', 03:56:55 INFO - 'tsvg_static']}, 03:56:55 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:56:55 INFO - 'tests': ['tsvgx', 03:56:55 INFO - 'tsvgr_opacity', 03:56:55 INFO - 'tart', 03:56:55 INFO - 'tscrollx', 03:56:55 INFO - 'tsvg_static']}, 03:56:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:56:55 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:56:55 INFO - 'talos_options': ['--disable-stylo'], 03:56:55 INFO - 'tests': ['tp5o']}, 03:56:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:56:55 INFO - 'talos_options': ['--mitmproxy', 03:56:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:56:55 INFO - '--firstNonBlankPaint'], 03:56:55 INFO - 'tests': ['tp6_google', 03:56:55 INFO - 'tp6_youtube', 03:56:55 INFO - 'tp6_amazon', 03:56:55 INFO - 'tp6_facebook']}, 03:56:55 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:56:55 INFO - 'talos_options': ['--disable-stylo', 03:56:55 INFO - '--mitmproxy', 03:56:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:56:55 INFO - '--firstNonBlankPaint'], 03:56:55 INFO - 'tests': ['tp6_google', 03:56:55 INFO - 'tp6_youtube', 03:56:55 INFO - 'tp6_amazon', 03:56:55 INFO - 'tp6_facebook']}, 03:56:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:56:55 INFO - 'talos_options': ['--stylo-threads=1', 03:56:55 INFO - '--mitmproxy', 03:56:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:56:55 INFO - '--firstNonBlankPaint'], 03:56:55 INFO - 'tests': ['tp6_google', 03:56:55 INFO - 'tp6_youtube', 03:56:55 INFO - 'tp6_amazon', 03:56:55 INFO - 'tp6_facebook']}, 03:56:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:56:55 INFO - 'talos_options': ['--xperf_path', 03:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:56:55 INFO - 'tests': ['tp5n']}, 03:56:55 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:56:55 INFO - 'talos_options': ['--disable-stylo', 03:56:55 INFO - '--xperf_path', 03:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:56:55 INFO - 'tests': ['tp5n']}}} 03:56:55 INFO - Running post-action listener: _resource_record_post_action 03:56:55 INFO - [mozharness: 2017-09-12 10:56:55.419640Z] Finished populate-webroot step (success) 03:56:55 INFO - [mozharness: 2017-09-12 10:56:55.419731Z] Running create-virtualenv step. 03:56:55 INFO - Running pre-action listener: _resource_record_pre_action 03:56:55 INFO - Running main action method: create_virtualenv 03:56:55 INFO - Creating virtualenv /builds/slave/test/build/venv 03:56:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:56:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:56:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:56:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:56:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:56:56 INFO - Installing distribute.............................................................................................................................................................................................done. 03:56:57 INFO - Installing pip...............done. 03:56:57 INFO - Return code: 0 03:56:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:56:57 INFO - Reading from file tmpfile_stdout 03:56:57 INFO - Output received: 03:56:57 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:56:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:57 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 0xaec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe58a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c090>, '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 0xe5cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe56f90>, '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': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:56:57 INFO - Using env: {'DISPLAY': ':0', 03:56:57 INFO - 'HOME': '/home/cltbld', 03:56:57 INFO - 'LANG': 'en_US.UTF-8', 03:56:57 INFO - 'LANGUAGE': 'en_US:en', 03:56:57 INFO - 'LOGNAME': 'cltbld', 03:56:57 INFO - 'MAIL': '/var/mail/cltbld', 03:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:57 INFO - 'MOZ_NO_REMOTE': '1', 03:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:57 INFO - 'NO_EM_RESTART': '1', 03:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:57 INFO - 'PWD': '/builds/slave/test', 03:56:57 INFO - 'SHELL': '/bin/bash', 03:56:57 INFO - 'SHLVL': '1', 03:56:57 INFO - 'TERM': 'linux', 03:56:57 INFO - 'TMOUT': '86400', 03:56:57 INFO - 'USER': 'cltbld', 03:56:57 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 03:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:57 INFO - '_': '/tools/buildbot/bin/python'} 03:56:58 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:56:58 INFO - Downloading/unpacking pip>=1.5 03:56:58 INFO - Running setup.py egg_info for package pip 03:56:58 INFO - warning: no files found matching 'pip/cacert.pem' 03:56:58 INFO - warning: no files found matching '*.html' under directory 'docs' 03:56:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:56:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:56:58 INFO - Installing collected packages: pip 03:56:58 INFO - Found existing installation: pip 1.1 03:56:58 INFO - Uninstalling pip: 03:56:58 INFO - Successfully uninstalled pip 03:56:58 INFO - Running setup.py install for pip 03:56:58 INFO - warning: no files found matching 'pip/cacert.pem' 03:56:58 INFO - warning: no files found matching '*.html' under directory 'docs' 03:56:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:56:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:56:58 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:56:58 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:56:58 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:56:58 INFO - Successfully installed pip 03:56:58 INFO - Cleaning up... 03:56:58 INFO - Return code: 0 03:56:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:56:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xaec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe58a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c090>, '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 0xe5cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe56f90>, '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': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:56:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:56:58 INFO - Using env: {'DISPLAY': ':0', 03:56:58 INFO - 'HOME': '/home/cltbld', 03:56:58 INFO - 'LANG': 'en_US.UTF-8', 03:56:58 INFO - 'LANGUAGE': 'en_US:en', 03:56:58 INFO - 'LOGNAME': 'cltbld', 03:56:58 INFO - 'MAIL': '/var/mail/cltbld', 03:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:58 INFO - 'MOZ_NO_REMOTE': '1', 03:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:56:58 INFO - 'NO_EM_RESTART': '1', 03:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:58 INFO - 'PWD': '/builds/slave/test', 03:56:58 INFO - 'SHELL': '/bin/bash', 03:56:58 INFO - 'SHLVL': '1', 03:56:58 INFO - 'TERM': 'linux', 03:56:58 INFO - 'TMOUT': '86400', 03:56:58 INFO - 'USER': 'cltbld', 03:56:58 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 03:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:58 INFO - '_': '/tools/buildbot/bin/python'} 03:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:56:58 INFO - Downloading/unpacking psutil>=3.1.1 03:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:56:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:56:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:56:59 INFO - Installing collected packages: psutil 03:56:59 INFO - Running setup.py install for psutil 03:56:59 INFO - building 'psutil._psutil_linux' extension 03:56:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:56:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:57:00 INFO - building 'psutil._psutil_posix' extension 03:57:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:57:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:57:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:57:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:57:00 INFO - Successfully installed psutil 03:57:00 INFO - Cleaning up... 03:57:00 INFO - Return code: 0 03:57:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xaec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe58a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c090>, '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 0xe5cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe56f90>, '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': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:57:00 INFO - Using env: {'DISPLAY': ':0', 03:57:00 INFO - 'HOME': '/home/cltbld', 03:57:00 INFO - 'LANG': 'en_US.UTF-8', 03:57:00 INFO - 'LANGUAGE': 'en_US:en', 03:57:00 INFO - 'LOGNAME': 'cltbld', 03:57:00 INFO - 'MAIL': '/var/mail/cltbld', 03:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:00 INFO - 'MOZ_NO_REMOTE': '1', 03:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:00 INFO - 'NO_EM_RESTART': '1', 03:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:00 INFO - 'PWD': '/builds/slave/test', 03:57:00 INFO - 'SHELL': '/bin/bash', 03:57:00 INFO - 'SHLVL': '1', 03:57:00 INFO - 'TERM': 'linux', 03:57:00 INFO - 'TMOUT': '86400', 03:57:00 INFO - 'USER': 'cltbld', 03:57:00 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 03:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:00 INFO - '_': '/tools/buildbot/bin/python'} 03:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:57:01 INFO - Installing collected packages: mozsystemmonitor 03:57:01 INFO - Running setup.py install for mozsystemmonitor 03:57:01 INFO - Successfully installed mozsystemmonitor 03:57:01 INFO - Cleaning up... 03:57:02 INFO - Return code: 0 03:57:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57: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')]} 03:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xaec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe58a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c090>, '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 0xe5cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe56f90>, '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': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:57:02 INFO - Using env: {'DISPLAY': ':0', 03:57:02 INFO - 'HOME': '/home/cltbld', 03:57:02 INFO - 'LANG': 'en_US.UTF-8', 03:57:02 INFO - 'LANGUAGE': 'en_US:en', 03:57:02 INFO - 'LOGNAME': 'cltbld', 03:57:02 INFO - 'MAIL': '/var/mail/cltbld', 03:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:02 INFO - 'MOZ_NO_REMOTE': '1', 03:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:02 INFO - 'NO_EM_RESTART': '1', 03:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:02 INFO - 'PWD': '/builds/slave/test', 03:57:02 INFO - 'SHELL': '/bin/bash', 03:57:02 INFO - 'SHLVL': '1', 03:57:02 INFO - 'TERM': 'linux', 03:57:02 INFO - 'TMOUT': '86400', 03:57:02 INFO - 'USER': 'cltbld', 03:57:02 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 03:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:02 INFO - '_': '/tools/buildbot/bin/python'} 03:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:02 INFO - Downloading/unpacking jsonschema==2.5.1 03:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:57:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:04 INFO - Downloading functools32-3.2.3-2.tar.gz 03:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:57:04 INFO - warning: no files found matching '*.txt' 03:57:04 INFO - no previously-included directories found matching 'build' 03:57:04 INFO - no previously-included directories found matching 'dist' 03:57:04 INFO - no previously-included directories found matching '.git*' 03:57:04 INFO - Installing collected packages: jsonschema, functools32 03:57:04 INFO - Running setup.py install for functools32 03:57:04 INFO - warning: no files found matching '*.txt' 03:57:04 INFO - no previously-included directories found matching 'build' 03:57:04 INFO - no previously-included directories found matching 'dist' 03:57:04 INFO - no previously-included directories found matching '.git*' 03:57:04 INFO - Successfully installed jsonschema functools32 03:57:04 INFO - Cleaning up... 03:57:04 INFO - Return code: 0 03:57:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:04 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 0xaec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe58a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c090>, '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 0xe5cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe56f90>, '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': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:57:04 INFO - Using env: {'DISPLAY': ':0', 03:57:04 INFO - 'HOME': '/home/cltbld', 03:57:04 INFO - 'LANG': 'en_US.UTF-8', 03:57:04 INFO - 'LANGUAGE': 'en_US:en', 03:57:04 INFO - 'LOGNAME': 'cltbld', 03:57:04 INFO - 'MAIL': '/var/mail/cltbld', 03:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:04 INFO - 'MOZ_NO_REMOTE': '1', 03:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:04 INFO - 'NO_EM_RESTART': '1', 03:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:04 INFO - 'PWD': '/builds/slave/test', 03:57:04 INFO - 'SHELL': '/bin/bash', 03:57:04 INFO - 'SHLVL': '1', 03:57:04 INFO - 'TERM': 'linux', 03:57:04 INFO - 'TMOUT': '86400', 03:57:04 INFO - 'USER': 'cltbld', 03:57:04 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 03:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:04 INFO - '_': '/tools/buildbot/bin/python'} 03:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:57:04 INFO - Cleaning up... 03:57:04 INFO - Return code: 0 03:57:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:04 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 0xaec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe58a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c090>, '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 0xe5cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe56f90>, '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': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:57:04 INFO - Using env: {'DISPLAY': ':0', 03:57:04 INFO - 'HOME': '/home/cltbld', 03:57:04 INFO - 'LANG': 'en_US.UTF-8', 03:57:04 INFO - 'LANGUAGE': 'en_US:en', 03:57:04 INFO - 'LOGNAME': 'cltbld', 03:57:04 INFO - 'MAIL': '/var/mail/cltbld', 03:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:04 INFO - 'MOZ_NO_REMOTE': '1', 03:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:04 INFO - 'NO_EM_RESTART': '1', 03:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:04 INFO - 'PWD': '/builds/slave/test', 03:57:04 INFO - 'SHELL': '/bin/bash', 03:57:04 INFO - 'SHLVL': '1', 03:57:04 INFO - 'TERM': 'linux', 03:57:04 INFO - 'TMOUT': '86400', 03:57:04 INFO - 'USER': 'cltbld', 03:57:04 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 03:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:04 INFO - '_': '/tools/buildbot/bin/python'} 03:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:04 INFO - Downloading/unpacking blobuploader==1.2.4 03:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:57:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:57:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:06 INFO - Downloading docopt-0.6.1.tar.gz 03:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:57:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:57:06 INFO - Running setup.py install for blobuploader 03:57:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:57:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:57:06 INFO - Running setup.py install for requests 03:57:06 INFO - Running setup.py install for docopt 03:57:07 INFO - Successfully installed blobuploader requests docopt 03:57:07 INFO - Cleaning up... 03:57:07 INFO - Return code: 0 03:57:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:07 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 0xaec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe58a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c090>, '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 0xe5cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe56f90>, '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': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:57:07 INFO - Using env: {'DISPLAY': ':0', 03:57:07 INFO - 'HOME': '/home/cltbld', 03:57:07 INFO - 'LANG': 'en_US.UTF-8', 03:57:07 INFO - 'LANGUAGE': 'en_US:en', 03:57:07 INFO - 'LOGNAME': 'cltbld', 03:57:07 INFO - 'MAIL': '/var/mail/cltbld', 03:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:07 INFO - 'MOZ_NO_REMOTE': '1', 03:57:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:07 INFO - 'NO_EM_RESTART': '1', 03:57:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:07 INFO - 'PWD': '/builds/slave/test', 03:57:07 INFO - 'SHELL': '/bin/bash', 03:57:07 INFO - 'SHLVL': '1', 03:57:07 INFO - 'TERM': 'linux', 03:57:07 INFO - 'TMOUT': '86400', 03:57:07 INFO - 'USER': 'cltbld', 03:57:07 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 03:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:07 INFO - '_': '/tools/buildbot/bin/python'} 03:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:07 INFO - Running setup.py (path:/tmp/pip-SdqxxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:07 INFO - Running setup.py (path:/tmp/pip-rXSsaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:07 INFO - Running setup.py (path:/tmp/pip-hGhzuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:07 INFO - Running setup.py (path:/tmp/pip-WnNQUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:07 INFO - Running setup.py (path:/tmp/pip-wRU9Bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:07 INFO - Running setup.py (path:/tmp/pip-zcE6Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:07 INFO - Running setup.py (path:/tmp/pip-zUVFqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:07 INFO - Running setup.py (path:/tmp/pip-sIRarF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:07 INFO - Running setup.py (path:/tmp/pip-gu00Fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:07 INFO - Running setup.py (path:/tmp/pip-K8DzZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:07 INFO - Running setup.py (path:/tmp/pip-xGH8AA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:08 INFO - Running setup.py (path:/tmp/pip-wrWY3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:08 INFO - Running setup.py (path:/tmp/pip-DMZql2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:08 INFO - Running setup.py (path:/tmp/pip-oi0mv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:08 INFO - Running setup.py (path:/tmp/pip-UuhfJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:08 INFO - Running setup.py (path:/tmp/pip-fNa43S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:08 INFO - Running setup.py (path:/tmp/pip-toJkYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:57:08 INFO - Running setup.py install for manifestparser 03:57:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:57:08 INFO - Running setup.py install for mozcrash 03:57:08 INFO - Running setup.py install for mozdebug 03:57:08 INFO - Running setup.py install for mozdevice 03:57:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:57:08 INFO - Running setup.py install for mozfile 03:57:08 INFO - Running setup.py install for mozhttpd 03:57:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Running setup.py install for mozinfo 03:57:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Running setup.py install for mozInstall 03:57:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Running setup.py install for mozleak 03:57:09 INFO - Running setup.py install for mozlog 03:57:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Running setup.py install for moznetwork 03:57:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Running setup.py install for mozprocess 03:57:09 INFO - Running setup.py install for mozprofile 03:57:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Running setup.py install for mozrunner 03:57:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:57:09 INFO - Running setup.py install for mozscreenshot 03:57:09 INFO - Running setup.py install for moztest 03:57:10 INFO - Running setup.py install for mozversion 03:57:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:57:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:57:10 INFO - Cleaning up... 03:57:10 INFO - Return code: 0 03:57:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:10 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 0xaec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe58a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c090>, '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 0xe5cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe56f90>, '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': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:57:10 INFO - Using env: {'DISPLAY': ':0', 03:57:10 INFO - 'HOME': '/home/cltbld', 03:57:10 INFO - 'LANG': 'en_US.UTF-8', 03:57:10 INFO - 'LANGUAGE': 'en_US:en', 03:57:10 INFO - 'LOGNAME': 'cltbld', 03:57:10 INFO - 'MAIL': '/var/mail/cltbld', 03:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:10 INFO - 'MOZ_NO_REMOTE': '1', 03:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:10 INFO - 'NO_EM_RESTART': '1', 03:57:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:10 INFO - 'PWD': '/builds/slave/test', 03:57:10 INFO - 'SHELL': '/bin/bash', 03:57:10 INFO - 'SHLVL': '1', 03:57:10 INFO - 'TERM': 'linux', 03:57:10 INFO - 'TMOUT': '86400', 03:57:10 INFO - 'USER': 'cltbld', 03:57:10 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 03:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:10 INFO - '_': '/tools/buildbot/bin/python'} 03:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:10 INFO - Running setup.py (path:/tmp/pip-1lm5AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:10 INFO - Running setup.py (path:/tmp/pip-t83N6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:10 INFO - Running setup.py (path:/tmp/pip-XumUjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:10 INFO - Running setup.py (path:/tmp/pip-w2ISRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:10 INFO - Running setup.py (path:/tmp/pip-TLmU4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:10 INFO - Running setup.py (path:/tmp/pip-I8KyrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:10 INFO - Running setup.py (path:/tmp/pip-LCPUQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:10 INFO - Running setup.py (path:/tmp/pip-krxuFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:11 INFO - Running setup.py (path:/tmp/pip-hUY0Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:11 INFO - Running setup.py (path:/tmp/pip-qC3J44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:11 INFO - Running setup.py (path:/tmp/pip-jU3iSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:11 INFO - Running setup.py (path:/tmp/pip-JobxzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:11 INFO - Running setup.py (path:/tmp/pip-WEuvu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:11 INFO - Running setup.py (path:/tmp/pip-Ppe3kG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:11 INFO - Running setup.py (path:/tmp/pip-QNVe2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:11 INFO - Running setup.py (path:/tmp/pip-uEta1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:11 INFO - Running setup.py (path:/tmp/pip-Q7098k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:57:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:12 INFO - Downloading blessings-1.6.tar.gz 03:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:57:12 INFO - Installing collected packages: blessings 03:57:12 INFO - Running setup.py install for blessings 03:57:12 INFO - Successfully installed blessings 03:57:12 INFO - Cleaning up... 03:57:12 INFO - Return code: 0 03:57:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:13 INFO - Reading from file tmpfile_stdout 03:57:13 INFO - Current package versions: 03:57:13 INFO - argparse == 1.2.1 03:57:13 INFO - blessings == 1.6 03:57:13 INFO - blobuploader == 1.2.4 03:57:13 INFO - docopt == 0.6.1 03:57:13 INFO - functools32 == 3.2.3-2 03:57:13 INFO - jsonschema == 2.5.1 03:57:13 INFO - manifestparser == 1.1 03:57:13 INFO - mozInstall == 1.13 03:57:13 INFO - mozcrash == 1.0 03:57:13 INFO - mozdebug == 0.1 03:57:13 INFO - mozdevice == 0.51 03:57:13 INFO - mozfile == 1.2 03:57:13 INFO - mozhttpd == 0.7 03:57:13 INFO - mozinfo == 0.10 03:57:13 INFO - mozleak == 0.1 03:57:13 INFO - mozlog == 3.5 03:57:13 INFO - moznetwork == 0.27 03:57:13 INFO - mozprocess == 0.25 03:57:13 INFO - mozprofile == 0.28 03:57:13 INFO - mozrunner == 6.13 03:57:13 INFO - mozscreenshot == 0.1 03:57:13 INFO - mozsystemmonitor == 0.3 03:57:13 INFO - moztest == 0.8 03:57:13 INFO - mozversion == 1.4 03:57:13 INFO - psutil == 3.1.1 03:57:13 INFO - requests == 1.2.3 03:57:13 INFO - wsgiref == 0.1.2 03:57:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:13 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 0xaec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe58a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c090>, '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 0xe5cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe56f90>, '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': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:57:13 INFO - Using env: {'DISPLAY': ':0', 03:57:13 INFO - 'HOME': '/home/cltbld', 03:57:13 INFO - 'LANG': 'en_US.UTF-8', 03:57:13 INFO - 'LANGUAGE': 'en_US:en', 03:57:13 INFO - 'LOGNAME': 'cltbld', 03:57:13 INFO - 'MAIL': '/var/mail/cltbld', 03:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:13 INFO - 'MOZ_NO_REMOTE': '1', 03:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:13 INFO - 'NO_EM_RESTART': '1', 03:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:13 INFO - 'PWD': '/builds/slave/test', 03:57:13 INFO - 'SHELL': '/bin/bash', 03:57:13 INFO - 'SHLVL': '1', 03:57:13 INFO - 'TERM': 'linux', 03:57:13 INFO - 'TMOUT': '86400', 03:57:13 INFO - 'USER': 'cltbld', 03:57:13 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 03:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:13 INFO - '_': '/tools/buildbot/bin/python'} 03:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:57:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:57:14 INFO - Installing collected packages: simplejson 03:57:14 INFO - Running setup.py install for simplejson 03:57:14 INFO - building 'simplejson._speedups' extension 03:57:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:57:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:57:15 INFO - Successfully installed simplejson 03:57:15 INFO - Cleaning up... 03:57:15 INFO - Return code: 0 03:57:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57: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')]} 03:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:15 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 0xaec1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe58a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c090>, '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 0xe5cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe56f90>, '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': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:57:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:57:15 INFO - Using env: {'DISPLAY': ':0', 03:57:15 INFO - 'HOME': '/home/cltbld', 03:57:15 INFO - 'LANG': 'en_US.UTF-8', 03:57:15 INFO - 'LANGUAGE': 'en_US:en', 03:57:15 INFO - 'LOGNAME': 'cltbld', 03:57:15 INFO - 'MAIL': '/var/mail/cltbld', 03:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:15 INFO - 'MOZ_NO_REMOTE': '1', 03:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:15 INFO - 'NO_EM_RESTART': '1', 03:57:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:15 INFO - 'PWD': '/builds/slave/test', 03:57:15 INFO - 'SHELL': '/bin/bash', 03:57:15 INFO - 'SHLVL': '1', 03:57:15 INFO - 'TERM': 'linux', 03:57:15 INFO - 'TMOUT': '86400', 03:57:15 INFO - 'USER': 'cltbld', 03:57:15 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 03:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:15 INFO - '_': '/tools/buildbot/bin/python'} 03:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:57:15 INFO - Cleaning up... 03:57:15 INFO - Return code: 0 03:57:15 INFO - Running post-action listener: _resource_record_post_action 03:57:15 INFO - Running post-action listener: _start_resource_monitoring 03:57:15 INFO - Starting resource monitoring. 03:57:15 INFO - [mozharness: 2017-09-12 10:57:15.911190Z] Finished create-virtualenv step (success) 03:57:15 INFO - [mozharness: 2017-09-12 10:57:15.911698Z] Running install step. 03:57:15 INFO - Running pre-action listener: _resource_record_pre_action 03:57:15 INFO - Running main action method: install 03:57:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:16 INFO - Reading from file tmpfile_stdout 03:57:16 INFO - Detecting whether we're running mozinstall >=1.0... 03:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:57:16 INFO - Reading from file tmpfile_stdout 03:57:16 INFO - Output received: 03:57:16 INFO - Usage: mozinstall [options] installer 03:57:16 INFO - Options: 03:57:16 INFO - -h, --help show this help message and exit 03:57:16 INFO - -d DEST, --destination=DEST 03:57:16 INFO - Directory to install application into. [default: 03:57:16 INFO - "/builds/slave/test"] 03:57:16 INFO - --app=APP Application being installed. [default: firefox] 03:57:16 INFO - mkdir: /builds/slave/test/build/application 03:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:57:32 INFO - Reading from file tmpfile_stdout 03:57:32 INFO - Output received: 03:57:32 INFO - /builds/slave/test/build/application/firefox/firefox 03:57:32 INFO - Running post-action listener: _resource_record_post_action 03:57:32 INFO - [mozharness: 2017-09-12 10:57:32.632037Z] Finished install step (success) 03:57:32 INFO - [mozharness: 2017-09-12 10:57:32.632292Z] Running setup-mitmproxy step. 03:57:32 INFO - Running pre-action listener: _resource_record_pre_action 03:57:32 INFO - Running main action method: setup_mitmproxy 03:57:32 INFO - Skipping: mitmproxy is not required 03:57:32 INFO - Running post-action listener: _resource_record_post_action 03:57:32 INFO - [mozharness: 2017-09-12 10:57:32.633487Z] Finished setup-mitmproxy step (success) 03:57:32 INFO - [mozharness: 2017-09-12 10:57:32.633707Z] Running run-tests step. 03:57:32 INFO - Running pre-action listener: _resource_record_pre_action 03:57:32 INFO - Running pre-action listener: _set_gcov_prefix 03:57:32 INFO - Running main action method: run_tests 03:57:32 WARNING - Try message not found. 03:57:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:57:32 INFO - Python 2.7.3 03:57:32 INFO - Return code: 0 03:57:32 INFO - grabbing minidump binary from tooltool 03:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c090>, '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 0xe5cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe56f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:57:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:57:32 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:57:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:57:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:57:32 INFO - Return code: 0 03:57:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:57:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:57:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:57:32 INFO - ENV: RUST_BACKTRACE is now full 03:57:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:57:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:57:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 03:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 03:57:32 INFO - Using env: {'DISPLAY': ':0', 03:57:32 INFO - 'HOME': '/home/cltbld', 03:57:32 INFO - 'LANG': 'en_US.UTF-8', 03:57:32 INFO - 'LANGUAGE': 'en_US:en', 03:57:32 INFO - 'LOGNAME': 'cltbld', 03:57:32 INFO - 'MAIL': '/var/mail/cltbld', 03:57:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:57:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:32 INFO - 'MOZ_NO_REMOTE': '1', 03:57:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:32 INFO - 'NO_EM_RESTART': '1', 03:57:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:32 INFO - 'PWD': '/builds/slave/test', 03:57:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:57:32 INFO - 'RUST_BACKTRACE': 'full', 03:57:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:57:32 INFO - 'SHELL': '/bin/bash', 03:57:32 INFO - 'SHLVL': '1', 03:57:32 INFO - 'TERM': 'linux', 03:57:32 INFO - 'TMOUT': '86400', 03:57:32 INFO - 'USER': 'cltbld', 03:57:32 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 03:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:32 INFO - '_': '/tools/buildbot/bin/python'} 03:57:32 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/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 03:57:33 INFO - mozversion application_buildid: 20170912093323 03:57:33 INFO - mozversion application_changeset: 175f1366daee80cde53386a4627402ed3af4c038 03:57:33 INFO - mozversion application_display_name: Nightly 03:57:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:57:33 INFO - mozversion application_name: Firefox 03:57:33 INFO - mozversion application_remotingname: firefox 03:57:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:57:33 INFO - mozversion application_vendor: Mozilla 03:57:33 INFO - mozversion application_version: 57.0a1 03:57:33 INFO - mozversion platform_buildid: 20170912093323 03:57:33 INFO - mozversion platform_changeset: 175f1366daee80cde53386a4627402ed3af4c038 03:57:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:57:33 INFO - mozversion platform_version: 57.0a1 03:57:33 INFO - using testdate: 1505213853 03:57:33 INFO - actual date: 1505213853 03:57:33 INFO - starting webserver on 'localhost:37127' 03:57:33 INFO - SUITE-START | Running 2 tests 03:57:33 INFO - TEST-START | dromaeo_css 03:57:33 INFO - Initialising browser for dromaeo_css test... 03:57:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37127/getInfo.html -profile /tmp/tmpWdyJVt/profile 03:57:33 INFO - TEST-INFO | started process 15096 (/builds/slave/test/build/application/firefox/firefox http://localhost:37127/getInfo.html) 03:57:38 INFO - TEST-INFO | 15096: exit 0 03:57:38 INFO - Browser initialized. 03:57:38 INFO - Running cycle 1/1 for dromaeo_css test... 03:57:38 INFO - Using env: {'DISPLAY': ':0', 03:57:38 INFO - 'HOME': '/home/cltbld', 03:57:38 INFO - 'JSGC_DISABLE_POISONING': '1', 03:57:38 INFO - 'LANG': 'en_US.UTF-8', 03:57:38 INFO - 'LANGUAGE': 'en_US:en', 03:57:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:57:38 INFO - 'LOGNAME': 'cltbld', 03:57:38 INFO - 'MAIL': '/var/mail/cltbld', 03:57:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:57:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:57:38 INFO - 'MOZ_CRASHREPORTER': '1', 03:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:57:38 INFO - 'MOZ_NO_REMOTE': '1', 03:57:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:38 INFO - 'NO_EM_RESTART': '1', 03:57:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:38 INFO - 'PWD': '/builds/slave/test', 03:57:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:57:38 INFO - 'RUST_BACKTRACE': 'full', 03:57:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:57:38 INFO - 'SHELL': '/bin/bash', 03:57:38 INFO - 'SHLVL': '1', 03:57:38 INFO - 'TERM': 'linux', 03:57:38 INFO - 'TMOUT': '86400', 03:57:38 INFO - 'USER': 'cltbld', 03:57:38 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 03:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:38 INFO - '_': '/tools/buildbot/bin/python'} 03:57:38 INFO - TEST-INFO | started process 15297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWdyJVt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:57:39 INFO - PID 15297 | 03:57:39 INFO - PID 15297 | (/builds/slave/test/build/application/firefox/firefox:15348): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:57:39 INFO - PID 15297 | 03:57:49 INFO - PID 15297 | RSS: Main: 164483072 03:57:49 INFO - PID 15297 | 04:00:47 INFO - PID 15297 | Cycle 1(1): loaded http://localhost:37127/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37127/tests/dromaeo/cssquery-ext.html) 04:00:48 INFO - PID 15297 | RSS: Main: 168419328 04:00:48 INFO - PID 15297 | 04:03:50 INFO - PID 15297 | Cycle 1(1): loaded http://localhost:37127/tests/dromaeo/cssquery-ext.html (next: http://localhost:37127/tests/dromaeo/cssquery-jquery.html) 04:03:50 INFO - PID 15297 | RSS: Main: 164388864 04:03:50 INFO - PID 15297 | 04:06:52 INFO - PID 15297 | Cycle 1(1): loaded http://localhost:37127/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37127/tests/dromaeo/cssquery-mootools.html) 04:06:53 INFO - PID 15297 | RSS: Main: 166813696 04:06:53 INFO - PID 15297 | 04:09:54 INFO - PID 15297 | Cycle 1(1): loaded http://localhost:37127/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37127/tests/dromaeo/cssquery-prototype.html) 04:09:55 INFO - PID 15297 | RSS: Main: 165339136 04:09:55 INFO - PID 15297 | 04:12:58 INFO - PID 15297 | Cycle 1(1): loaded http://localhost:37127/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37127/tests/dromaeo/cssquery-yui.html) 04:12:58 INFO - PID 15297 | RSS: Main: 164474880 04:12:58 INFO - PID 15297 | 04:16:00 INFO - PID 15297 | Cycle 1(1): loaded http://localhost:37127/tests/dromaeo/cssquery-yui.html (next: http://localhost:37127/tests/dromaeo/cssquery-dojo.html) 04:16:00 INFO - PID 15297 | RSS: Main: 168849408 04:16:00 INFO - PID 15297 | 04:16:00 INFO - PID 15297 | __start_tp_report 04:16:00 INFO - PID 15297 | _x_x_mozilla_page_load 04:16:00 INFO - PID 15297 | _x_x_mozilla_page_load_details 04:16:00 INFO - PID 15297 | |i|pagename|runs| 04:16:00 INFO - PID 15297 | |0;dojo.html;3864.86472973446;3872.6514613684767;3873.980630096849;3894.221155768845;3899.7855117968534;6076.544259180557;6112.541559383042;6199.132121502993;6214.782482613109;6230.408111229432;6207.193064901568;6216.84457888553;6240.84397890053;6263.7494500220055;6267;5546.168074788794;5555.666660000393;5598.076317407623;5602.7758889644565;5694.77220911163;5657.038303488396;5677.48902598766;5691.345495268056;5746;5748.45389687979;5684.488396044355;5692.345380281258;5722.856928576777;5766.106253530709;5782.971085144568;5466.9179962300595;5549.278593782782;5636.436356364372;5673.8581535461535;5699.68651724155;5538.280023596947;5587.189857470685;5634.126710359901;5673.12066629669;5687.573431992617;6018.067199584071;6105.114758360013;6185.195924529828;6220.87558248837;6244.750209991595;6738.52830301879;6781.593104413751;6805.6597170141295;6831.931680683179;6846.144231971004;6814.250432452426;6841.144856892888;6854.280300568468;6915.031895534629;6934.202566704793;6289.685515724195;6340.080688300217;6377.107204991305;6409.391107844747;6422.261439934374;6943.965280173667;6995.965020174866;7018.964905175543;7026.894596581055;7043.436525077981;6607.603543787388;6651.66741662915;6685.231198412148;6742.629155396402;6779.559328643622;6588.04473351371;6690.665466726644;6772.322767723287;6851.931480685129;6860.0738900247825;6683.6324002180345;6725.630090345078;6743.662816859138;6762.087118239073;6770.593764374154;6775.559588626724;6777.186737591422;6832;6870.45036397087;6872.209695885037;4824.179889418807;4967.178322886319;5009.724465154379;5030.647854650139;5046.318746969112;4456.487503937024;4487.820487180476;4492.303692927601;4499.662525310615;4515.435570553681;6106.480949119375;6130.693465326805;6131.601445906002;6138.416850399205;6197.25632924052;6664.333566643297;6729.1252137221845;6763.661816909135;6838.48711346651;6853.109095817512;5981.850453738604;6119.173911521976;6184.5980011299125;6186.505079593621;6196.659183744938;5403.756830942617;5420.430854760272;5478.726063696799;5479.6164268500825;5498.780048798003;6960.860782784316;7023.719051237996;7029;7045.506814523037;7063.646817659096;6590.703418346282;6618.536702430783;6624.138861948012;6662.700178492077;6699.062131301719;7042.471814614027;7107.75122870697;7110.85778284421;7127.216006239413;7142.714291428285;6694.531382803157;6775.322467753185;6783.3555812197765;6784.728610855511;6787.660616969033;6721.294264102395;6787.321267873173;6809.897851532132;6899.103116595012;6907.309269073053;6367.87264254703;6491.026346048131;6543.934560654523;6621.867562648817;6622.503312251697;6533.509986751108;6553.5084868634085;6565.244996825426;6571.507136964842;6587.901181482186;6394.808155755335;6425.614463132227;6429;6448.935510644834;6514.022896565363;6407.391297826699;6422.614643121427;6485.416312531895;6560.245571759118;6679.298673639198;6371.490280777434;6397.3282805306635;6399.616023038632;6411.903821442589;6417.422431981144 04:16:00 INFO - PID 15297 | |1;ext.html;927.1516562345454;940.2900809888533;961.0581630002597;992.8758905136858;1000.5197505197505;42112;42745.35881961773;42936.35595466063;42982;43023.35464968028;40553.39169912446;41112.17775644486;41226.175476490454;41275.79362103193;41294.7935260324;7306.232845551221;7368.631568421584;7380.966664666951;7447.702091916317;7451.7019319227165;7285.817854553626;7342.743003994861;7359.4480413968895;7363.705451781922;7400.296971787671;7916.366690664733;8104.5542495162745;8106.837863242732;8107.716229931953;8107.878381824277;8006.719764808233;8035.276825085741;8064.072631647318;8067.717629882955;8071.354291656653;7761.417893657942;7982.32150267228;7982.722764357675;7984.161663025415;7991.041075071029;37934.241315173545;38270.42594361059;38323.808380958195;38362.80818595889;38369;3745.0824547985644;3790.639889210521;3791.9241615167543;3794.544654641433;3796.126890815128;32886.177845553815;33010.504842427385;33112.33775324504;33189.33621327584;33269.667303326896;5400.324959380077;5400.405955344909;5422.0511410503;5422.40353561108;5440.483154100394;214709;215890;216225;216516;216689;50929;51097.744511277946;51261.48738512567;51520.48479515157;51656.483435165916;54311;54664.18003729947;54774.72612636911;54817;54944.72527637416;16760.413385531447;17106.144692765312;17138.742918856227;17146.91426542884;17148.828511714724;13876.167429954236;13893.235872027135;13893.513727019506;13919.164850109026;13940.233287169303;15119.16844573559;15315.463958761613;15368;15392;15444.845551544566;5946.910796338058;6036.547258955596;6082.361352058058;6196.194494715748;6346.174997250328;1088.482970588964;1089.8801131875487;1092.3391348234363;1106.9446527673583;1108.5288752280248;25135.497290054096;25202.621960670604;25497.490050198892;25598.10406635796;25612;1203.085654902263;1204.5362535423924;1207.8067509198486;1212.672578403826;1212.9514819407125;13329;13425.26161061151;13500.459981600823;13525.864741352658;13780.931095344458;265357;268434;283786;284994;286420;49923;50571.241431378556;54501.45498545043;56478.152827707614;57567.712161438925;1507.366905899525;1518.772184172361;1532.1037193241855;1532.4176812811284;1535.1786794065122;30208.54687179738;30490.390192195588;30591.54112688267;30612;30817.229569260948;39975.20049598934;40063.39904901487;40221.1955760889;40256.79871600623;40394;231421;231506;231634;232191;232804;34927.12682182864;34948.30103397969;34991.65008349884;35250.64749352474;35285.64714352824;44404.777976109915;45392;46019.539804601525;46065;46174.53825461702;34040.48939265963;34157.31685366329;34570.30859382748;34856.47715284323;34993.82503087468;33903;34154.48768268528;34319.828400857834;34912;34935.825320873235;39840.800795995834;39846.60153398429;40098.59901401065;40335.1932961345;40469;33529.66470335265;33615;33760.324793504486;33810;34146.31707365889;25093.498130037664;25946.74053259443;26103;26408.471830563667;26544 04:16:00 INFO - PID 15297 | |2;jquery.html;608.2974164839612;608.9878202435954;609.2354095610009;617.901135818269;628.8993760998242;23179.884100579493;23750.287491375242;23765.762342376573;23778.5244295114;23876;24481.632775508337;26164.86917565414;26288.21135365937;26355.604665930026;26425.339366515847;6645.867082658344;6828.078209441736;6829.180498340206;6838.692258848364;6854.074699915497;6468.191476065492;6724.361185687377;6726.394624483795;6728.259891411941;6759.797206083801;6691.330866913294;6692.765753198639;6702.162229721285;6705.832354191136;6709.765158219463;6681.632510211936;6692.196936367618;6692.9330706693045;6698.83252918681;6714.731410743613;6240.781572644981;6245.906311405332;6266.436020758154;6280.528960327993;6292.024736165901;29313.70686293131;29414.26464338387;30374.696253037408;30492.08523744269;30502.694973050428;2209.8784566848976;2248.4828489447355;2253.233900473847;2254.1546919905036;2254.6843441918145;20086.296979605642;20681.68977465339;20690.379288621367;20699.689504657443;20759.58480830375;2514.949701005988;2532.632768248612;2575.6780402449695;2593.286846117314;2624.9606255905987;130161.34919325342;136085;136158;143204;150236.9999999989;15502.30239639219;15986.60033499172;16150.19249037567;16274.349026038826;16657.750133748003;24933.252002439956;25038.248852534452;25038.749612504005;25079.498410031698;25086;10799.298045627009;10905.345679259111;10943.124550035978;11010.339379637247;11039.448027598748;10061.346012509164;10063.446510441996;10071.848922266172;10137.442440665835;10148.543315550818;9787.608495660237;9811.607535698635;9855.476231934586;10095.141912937335;10124.038216369434;2890.7109289070922;2917.460269850042;2961.644602647696;2970.1089673097986;3013.9547906781418;1035.4460363705382;1053.2416660004785;1054.2620165883911;1055.7307886488895;1056.7252514346326;20759.792402076087;21240.362789116352;21339.35981920545;21650;21801.236956706438;1093.6008356949815;1119.7200699825044;1127.2560110327145;1128.2497139402205;1139.703677043958;11570.3717763647;11636.010939070104;11820.645380638594;11882;11912.285262884254;542352;544846;550026;569477;570152;132454;137109.3144534271;138370;138821;142409;1095.6274866545414;1136.579465597734;1203.6810245285008;1210.5036934856666;1265.4432049898016;21579.057675225875;22001.11995520161;22073.558528829013;22120.115195392005;22192.334229973127;63123.6843815778;63170.36829631829;63251;64040.7191856151;66730;82858.5857070735;82961.58519207606;83542;83556.58221708852;83851;15052.774208387102;15238.619034524225;15443.150626715638;15457.458988935334;15673.294701738221;24078.87960560186;24281.39296517601;24283.39291517726;24357.26928192157;24506.142285019938;19082.904585476983;19411.126499307284;19741.111649975497;19833.50416239548;19838.801611983694;17494.125293735007;17503;17640.1179941005;18104.366347177787;18164.09179541044;19302.61394772125;19974.10116544788;19998.100085496477;20078.397648070582;20246.898765506077;12611.432485538357;14467.78298325547;15061.698766024838;15106.39574417011;15127.243637817845;19355.709664355327;19440.8055919439;19726.901365493082;19879.900600496905;19881.204751809764 04:16:00 INFO - PID 15297 | |3;mootools.html;1389.319233575548;1476.0922032949732;1481.8814494840415;1483.0656686287637;1495.2150121186376;16301.266443010063;16869.91565042176;16870.409535666255;16902.07038612876;16921.238544265507;16675.583110422245;16682.58293542659;16727;16730.24713887875;16820.74768878468;2774;2787.1499192746205;2811.704770999046;2825.8163219390776;2829.5472724364104;2801.355688191717;2818.9436211275865;2833.5183018886737;2839.843808590527;2841.3891013432108;2699.1362763915554;2704.8241864278757;2939.941201175986;2940.2355387599273;2940.558916162582;2788.0659978907092;2802.299425143714;2820.858957052139;2833.235026542832;2833.943321133576;2696.7842572594145;2793.385455199853;2800.1179628417185;2803.523401021831;2804.2288370698016;16291.103989280586;16360.754588681179;16476;16514;16524.75212871808;8237.958810205912;8554;8568.528730919797;8574.35692323072;8577.914220857836;5599.384067752544;5757.884842303172;5797;5873.2952045754355;5889.911651325234;2045.1103769860158;2046.4576887124774;2047.3346162497098;2053.065855035955;2093.0790452201136;30073;30336.089917302517;30378.54432183519;30472.54291185634;30492;7183.92816071843;7221.602811845399;7252.129744430702;7339.752242118852;7346.853062938711;19576.21695132179;19581;19612.803871961383;19695.60608787816;19712.21151153938;8563.186497282748;8703.086175951561;8780.209781119729;8801.735947921572;8802.295816334678;7712.383009359238;7777.261160189773;7815.882761758578;7874.72438464651;7884.487508311941;5491.835244942658;5646.604737668324;5669.858253543612;5687.232223649837;5755.3381361143165;1626.1786798785436;1640.958976025609;1642.1624971264741;1648.620817212024;1656.8840181187202;968.1286841842398;974.3715303629119;981.8969008254173;983.3952119446488;1009.1825621246813;9150.084991500797;9238.722838314861;9266.721998340061;9351.064893510595;9363.578638961262;768.2394429514852;796.3469954637142;807.075898096676;812.1391325195311;819.7376839411331;5465.207544905967;5688.715564221772;5723.77104915807;5734.111212762028;5825.883482330414;24718.629220561706;25504.489910201693;25629.743702562737;25660.10189643391;25771.871140644176;24149;25133.62299565508;25141.24576262715;25183.496330073664;25272.36819079501;12366.876331236572;12829;12867.42096605655;12891.935540322425;12905.612831614879;9148.679796207101;9212.539373031455;9276.72169834906;9289.34974551775;9311.487868167316;20802.79197208069;21159.365219043455;21204.15183392647;21471.355859324245;21499;21839.235626752987;21914.23300184486;22105;22125.446863828533;22251.554968900855;12303.44634491432;12312.445939932546;12436.751264974831;12440.19138755978;12520.624381268577;15542.30059647296;15811;15816;15823.762643560125;15840.128792916501;11716.472758725708;11781.293122412682;11886.108541859223;11887;12038.03695704359;12513.249205047727;12597.685057873627;12636;12673.873261267268;12765.170263932814;10769.676909692722;10988;11067.059299959594;11079.61221357281;11102.777944441228;8313.625886834985;8356.080831108695;8367.790805229675;8448.366372522209;8490.617922193393;8452.535110568977;8533.146685331418;8557;8557.57212139403;8697.173768491983 04:16:00 INFO - PID 15297 | |4;prototype.html;525.3197109742882;563.7519491423773;569.1320735877787;576.0984059946184;594.9970250148749;6147.508199344053;6199.256089269288;6238.594491358064;6383.138276332694;6393.584417012902;6282.717277722502;6305.4009869062365;6307.306196318401;6353.745850165988;6373.776917807878;5213.973930130344;5216.452272511388;5232.398274198459;5253.8949221015555;5255.789768409259;5085.211792172219;5242.8689282767855;5243.187305967581;5257.342832145981;5276.604254680914;5200.997615917861;5207.4792520748;5210.843674689765;5216.6869987800665;5227.294315267447;5214.400343960437;5229.790808367661;5235.057689615886;5283.815066472655;5308.336457942757;4992.725400102993;5004.099262132815;5009.348784657971;5018.272350509155;5035.370578677665;6137;6201.317855035987;6254.061890716429;6297.118403423525;6355.777547785805;6166.691665416712;6233.96883015582;6242.531810114214;6254.874902501924;6263.279722831841;6628.138342015555;6656.106177885942;6657.40083392497;6667.733290668368;6733.663316834188;5495;5505.229267902497;5515.227868098469;5556.305326875301;5567.858588989247;7007.789766307019;7104.822379440504;7150.964245178793;7164.641767911584;7177.784666460015;5681.857953551112;5709.457601527848;5771.105478650816;5778.017736984639;5800.854978625568;5798.391168927286;5808.273965754281;5881.764729410861;5896.882062358729;5902.734376953047;6155.169052177988;6188.504919606421;6208.906866397007;6246.75012999484;6249.562530622813;6485;6490.350964903472;6699.732010719614;6727.461803055744;6858.588484690935;1976.7034944758402;1986.4636548131923;2003.058562475634;2018.6265540874692;2020.8989550522415;1490.7912892195102;1510.3731951240113;1512.3043400036106;1515.6665533582593;1518.7342215112312;5982.551308651869;6001.699915004232;6149.600275982047;6152.723127459186;6159.291681456601;6729.360710732571;6741.898871516931;6806.149231346082;6818.522703410813;6848.794536163923;6138.202033735586;6158.351908679311;6174.413430724074;6209.627422354673;6239.1577137085915;3572.464130380412;3573.285342931424;3582.8566857325936;3612.692921101736;3632.927341453209;7128.893066604005;7154.35610795031;7156.320149585781;7176.892346614805;7214.747483838146;6966.582005079711;6996.705609462266;7052.823679408056;7078.292170782881;7098.273406461546;7102.218755936843;7105.396041336441;7136.964315178391;7157.033800436874;7186.209516953131;6743.865122697421;6794.524383293122;6817.625030623165;6893.448524118159;6904.240533541407;6649.667516624053;6747.865042699217;6758.290379510081;6818.113645226089;6845.418139458003;7012.493753123438;7047.541909775849;7128.6792094356915;7134.429245660439;7173.1392232932385;5200.557952573922;5218.66078704883;5218.843434696965;5252.501012403815;5263.89472210546;6818.727250909908;6839.640324088182;6863.2793556677825;6909.2745261748805;6920.238773734784;6608.43828274602;6636.933630663631;6663.733450662113;6665.900011499928;6670.733170673313;6498.935010649833;6566.376194261537;6569.178852643419;6598.769043083469;6634.341414646338;6421.71102300407;6423.807285781434;6534.444572211415;6603.669816509059;6627.1716035495565;6192.287886892885;6404.487640988803;6522.695460907743;6644.269130395556;6667.933320666732;6349.904751428639;6380.617162970237;6404.551681382259;6425.710843012169;6504.284528701934 04:16:00 INFO - PID 15297 | |5;yui.html;974.3715303629159;980.9400259455143;1002.1481740520559;1002.7292630989638;1013.0679774607361;23558.88220558899;25794.87102564487;25835.354116147104;25854.35364115898;25880.870595647044;21840.781592184074;22858.99999999996;23133.30600081996;23347.066117355327;23354.532909341804;1064.9574017039308;1087.7171935296801;1088.5645741703304;1088.8149014667526;1089.3681664634532;1103.2442776697987;1109.2623405435415;1113.1261959361902;1115.0577761791274;1117.4412793603199;1155.7515134246134;1159.5187996981285;1163.081165878959;1163.8894305041008;1163.9534418623246;1105.5135740274254;1112.6161474291357;1140.321508702325;1145.34715212329;1145.6792098212472;824.9587520624004;826.7023871406288;829.4857188543082;830.4228561150003;831.2601784411878;21591.1363545458;21685.67471487929;21773.891130544245;21787.455313617127;21810.127594896185;15334.846651533453;21790.346289611178;22323.776762232334;22843.657345139836;23002.76997230023;17863.553411164823;18003.369882054198;18213.45359639213;18260.634787304178;18281.085945702795;4003.939940900889;4084.9387259191135;4085.20338533986;4085.775282359469;4087.693422993287;159411;161203.5518579267;162735.1863240688;163041;163141;17473.47579572615;17794.288228470974;17815.910920445316;17816.643667126584;17863.46409607714;29361.265968350534;34253.486197707054;34290.14274643104;34324.313513730085;36031.4595281071;9658.323917325719;9862.852057219148;9897;9897.950510247547;9906.207503399855;4490.416245888014;4503.166914120898;4524.524924882906;4555.2256116460285;4582.679212455096;6102.603330783485;6272.717727702173;6303.3066362700065;6347.270063942613;6350.936490635035;1252.2549083295426;1267.5626908716479;1271.211848653822;1275.655572995286;1279.584135156078;726.672997151284;738.1363804348817;738.9408847292203;750.5234176297981;761.7981234972737;12725.363731813557;13247.972172661415;13939.581812545639;14403.279836008367;14468.27658617086;718.0557566799641;730.3098571849551;738.0368618952318;738.3391864281546;743.0971369785736;5851.795187168429;5919.644821310735;6038.275406951194;6096.329403765582;6137.925862974051;151808.2409587945;152325;153526;153635;161665;126316.36841815732;129971;130696;134262;134640;119254.40372798254;119317.22731090659;119833;120179.39910300393;120772.39613801875;11187.944060279646;11217.60738374153;11425.60010399632;11708.121890858049;11729.589464368706;54621;55131.44868551263;55621.16568251399;55820;56989.43010569841;73151.26848731445;73589.63205183939;73632.26367736468;75468.62265688636;75692.62153689197;16147.515574532783;19307.227710891406;20104.095315710536;20108.39674809758;20108.39674809758;21500;21683.241086561895;21902.342929712133;22356.664650029936;22374.664380033988;18088.00515971634;18439.81560184381;21174.153033878472;21289.254876079263;21493.355199344045;20874.37376878696;20993.685094723896;21055.368338949855;21116.78883211148;21201.787982119982;19008.42974710761;19109.140088695764;19237.03814809282;19330.22679092877;19415.902920485307;13808.792868107188;13972.231527266098;14518.637034074232;14755.040922340013;14781.260936953324;14342.928285358506;15011.47459838944;15323.770143447635;15820.841791581937;16021.919890400473 04:16:00 INFO - PID 15297 | __end_tp_report 04:16:00 INFO - PID 15297 | __start_cc_report 04:16:00 INFO - PID 15297 | _x_x_mozilla_cycle_collect,365 04:16:00 INFO - PID 15297 | __end_cc_report 04:16:00 INFO - PID 15297 | __startTimestamp1505214960603__endTimestamp 04:16:00 INFO - PID 15297 | 04:16:00 INFO - PID 15297 | ------- Summary: start ------- 04:16:00 INFO - PID 15297 | Number of tests: 6 04:16:00 INFO - PID 15297 | 04:16:00 INFO - PID 15297 | [#0] dojo.html Cycles:165 Average:6228.19 Median:6422.26 stddev:737.44 (11.5%) stddev-sans-first:716.01 04:16:00 INFO - PID 15297 | Values: 3864.9 3872.7 3874.0 3894.2 3899.8 6076.5 6112.5 6199.1 6214.8 6230.4 6207.2 6216.8 6240.8 6263.7 6267.0 5546.2 5555.7 5598.1 5602.8 5694.8 5657.0 5677.5 5691.3 5746.0 5748.5 5684.5 5692.3 5722.9 5766.1 5783.0 5466.9 5549.3 5636.4 5673.9 5699.7 5538.3 5587.2 5634.1 5673.1 5687.6 6018.1 6105.1 6185.2 6220.9 6244.8 6738.5 6781.6 6805.7 6831.9 6846.1 6814.3 6841.1 6854.3 6915.0 6934.2 6289.7 6340.1 6377.1 6409.4 6422.3 6944.0 6996.0 7019.0 7026.9 7043.4 6607.6 6651.7 6685.2 6742.6 6779.6 6588.0 6690.7 6772.3 6851.9 6860.1 6683.6 6725.6 6743.7 6762.1 6770.6 6775.6 6777.2 6832.0 6870.5 6872.2 4824.2 4967.2 5009.7 5030.6 5046.3 4456.5 4487.8 4492.3 4499.7 4515.4 6106.5 6130.7 6131.6 6138.4 6197.3 6664.3 6729.1 6763.7 6838.5 6853.1 5981.9 6119.2 6184.6 6186.5 6196.7 5403.8 5420.4 5478.7 5479.6 5498.8 6960.9 7023.7 7029.0 7045.5 7063.6 6590.7 6618.5 6624.1 6662.7 6699.1 7042.5 7107.8 7110.9 7127.2 7142.7 6694.5 6775.3 6783.4 6784.7 6787.7 6721.3 6787.3 6809.9 6899.1 6907.3 6367.9 6491.0 6543.9 6621.9 6622.5 6533.5 6553.5 6565.2 6571.5 6587.9 6394.8 6425.6 6429.0 6448.9 6514.0 6407.4 6422.6 6485.4 6560.2 6679.3 6371.5 6397.3 6399.6 6411.9 6417.4 04:16:00 INFO - PID 15297 | 04:16:00 INFO - PID 15297 | [#1] ext.html Cycles:180 Average:41809.55 Median:19515.36 stddev:63194.91 (323.8%) stddev-sans-first:63297.63 04:16:00 INFO - PID 15297 | Values: 927.2 940.3 961.1 992.9 1000.5 42112.0 42745.4 42936.4 42982.0 43023.4 40553.4 41112.2 41226.2 41275.8 41294.8 7306.2 7368.6 7381.0 7447.7 7451.7 7285.8 7342.7 7359.4 7363.7 7400.3 7916.4 8104.6 8106.8 8107.7 8107.9 8006.7 8035.3 8064.1 8067.7 8071.4 7761.4 7982.3 7982.7 7984.2 7991.0 37934.2 38270.4 38323.8 38362.8 38369.0 3745.1 3790.6 3791.9 3794.5 3796.1 32886.2 33010.5 33112.3 33189.3 33269.7 5400.3 5400.4 5422.1 5422.4 5440.5 214709.0 215890.0 216225.0 216516.0 216689.0 50929.0 51097.7 51261.5 51520.5 51656.5 54311.0 54664.2 54774.7 54817.0 54944.7 16760.4 17106.1 17138.7 17146.9 17148.8 13876.2 13893.2 13893.5 13919.2 13940.2 15119.2 15315.5 15368.0 15392.0 15444.8 5946.9 6036.5 6082.4 6196.2 6346.2 1088.5 1089.9 1092.3 1106.9 1108.5 25135.5 25202.6 25497.5 25598.1 25612.0 1203.1 1204.5 1207.8 1212.7 1213.0 13329.0 13425.3 13500.5 13525.9 13780.9 265357.0 268434.0 283786.0 284994.0 286420.0 49923.0 50571.2 54501.5 56478.2 57567.7 1507.4 1518.8 1532.1 1532.4 1535.2 30208.5 30490.4 30591.5 30612.0 30817.2 39975.2 40063.4 40221.2 40256.8 40394.0 231421.0 231506.0 231634.0 232191.0 232804.0 34927.1 34948.3 34991.7 35250.6 35285.6 44404.8 45392.0 46019.5 46065.0 46174.5 34040.5 34157.3 34570.3 34856.5 34993.8 33903.0 34154.5 34319.8 34912.0 34935.8 39840.8 39846.6 40098.6 40335.2 40469.0 33529.7 33615.0 33760.3 33810.0 34146.3 25093.5 25946.7 26103.0 26408.5 26544.0 04:16:00 INFO - PID 15297 | 04:16:00 INFO - PID 15297 | [#2] jquery.html Cycles:180 Average:38422.38 Median:12165.00 stddev:93432.83 (768.0%) stddev-sans-first:93651.79 04:16:00 INFO - PID 15297 | Values: 608.3 609.0 609.2 617.9 628.9 23179.9 23750.3 23765.8 23778.5 23876.0 24481.6 26164.9 26288.2 26355.6 26425.3 6645.9 6828.1 6829.2 6838.7 6854.1 6468.2 6724.4 6726.4 6728.3 6759.8 6691.3 6692.8 6702.2 6705.8 6709.8 6681.6 6692.2 6692.9 6698.8 6714.7 6240.8 6245.9 6266.4 6280.5 6292.0 29313.7 29414.3 30374.7 30492.1 30502.7 2209.9 2248.5 2253.2 2254.2 2254.7 20086.3 20681.7 20690.4 20699.7 20759.6 2514.9 2532.6 2575.7 2593.3 2625.0 130161.3 136085.0 136158.0 143204.0 150237.0 15502.3 15986.6 16150.2 16274.3 16657.8 24933.3 25038.2 25038.7 25079.5 25086.0 10799.3 10905.3 10943.1 11010.3 11039.4 10061.3 10063.4 10071.8 10137.4 10148.5 9787.6 9811.6 9855.5 10095.1 10124.0 2890.7 2917.5 2961.6 2970.1 3014.0 1035.4 1053.2 1054.3 1055.7 1056.7 20759.8 21240.4 21339.4 21650.0 21801.2 1093.6 1119.7 1127.3 1128.2 1139.7 11570.4 11636.0 11820.6 11882.0 11912.3 542352.0 544846.0 550026.0 569477.0 570152.0 132454.0 137109.3 138370.0 138821.0 142409.0 1095.6 1136.6 1203.7 1210.5 1265.4 21579.1 22001.1 22073.6 22120.1 22192.3 63123.7 63170.4 63251.0 64040.7 66730.0 82858.6 82961.6 83542.0 83556.6 83851.0 15052.8 15238.6 15443.2 15457.5 15673.3 24078.9 24281.4 24283.4 24357.3 24506.1 19082.9 19411.1 19741.1 19833.5 19838.8 17494.1 17503.0 17640.1 18104.4 18164.1 19302.6 19974.1 19998.1 20078.4 20246.9 12611.4 14467.8 15061.7 15106.4 15127.2 19355.7 19440.8 19726.9 19879.9 19881.2 04:16:00 INFO - PID 15297 | 04:16:00 INFO - PID 15297 | [#3] mootools.html Cycles:180 Average:10444.53 Median:2787.61 stddev:7718.14 (276.9%) stddev-sans-first:7709.81 04:16:00 INFO - PID 15297 | Values: 1389.3 1476.1 1481.9 1483.1 1495.2 16301.3 16869.9 16870.4 16902.1 16921.2 16675.6 16682.6 16727.0 16730.2 16820.7 2774.0 2787.1 2811.7 2825.8 2829.5 2801.4 2818.9 2833.5 2839.8 2841.4 2699.1 2704.8 2939.9 2940.2 2940.6 2788.1 2802.3 2820.9 2833.2 2833.9 2696.8 2793.4 2800.1 2803.5 2804.2 16291.1 16360.8 16476.0 16514.0 16524.8 8238.0 8554.0 8568.5 8574.4 8577.9 5599.4 5757.9 5797.0 5873.3 5889.9 2045.1 2046.5 2047.3 2053.1 2093.1 30073.0 30336.1 30378.5 30472.5 30492.0 7183.9 7221.6 7252.1 7339.8 7346.9 19576.2 19581.0 19612.8 19695.6 19712.2 8563.2 8703.1 8780.2 8801.7 8802.3 7712.4 7777.3 7815.9 7874.7 7884.5 5491.8 5646.6 5669.9 5687.2 5755.3 1626.2 1641.0 1642.2 1648.6 1656.9 968.1 974.4 981.9 983.4 1009.2 9150.1 9238.7 9266.7 9351.1 9363.6 768.2 796.3 807.1 812.1 819.7 5465.2 5688.7 5723.8 5734.1 5825.9 24718.6 25504.5 25629.7 25660.1 25771.9 24149.0 25133.6 25141.2 25183.5 25272.4 12366.9 12829.0 12867.4 12891.9 12905.6 9148.7 9212.5 9276.7 9289.3 9311.5 20802.8 21159.4 21204.2 21471.4 21499.0 21839.2 21914.2 22105.0 22125.4 22251.6 12303.4 12312.4 12436.8 12440.2 12520.6 15542.3 15811.0 15816.0 15823.8 15840.1 11716.5 11781.3 11886.1 11887.0 12038.0 12513.2 12597.7 12636.0 12673.9 12765.2 10769.7 10988.0 11067.1 11079.6 11102.8 8313.6 8356.1 8367.8 8448.4 8490.6 8452.5 8533.1 8557.0 8557.6 8697.2 04:16:00 INFO - PID 15297 | 04:16:00 INFO - PID 15297 | [#4] prototype.html Cycles:180 Average:5786.48 Median:6259.08 stddev:1547.53 (24.7%) stddev-sans-first:1500.65 04:16:00 INFO - PID 15297 | Values: 525.3 563.8 569.1 576.1 595.0 6147.5 6199.3 6238.6 6383.1 6393.6 6282.7 6305.4 6307.3 6353.7 6373.8 5214.0 5216.5 5232.4 5253.9 5255.8 5085.2 5242.9 5243.2 5257.3 5276.6 5201.0 5207.5 5210.8 5216.7 5227.3 5214.4 5229.8 5235.1 5283.8 5308.3 4992.7 5004.1 5009.3 5018.3 5035.4 6137.0 6201.3 6254.1 6297.1 6355.8 6166.7 6234.0 6242.5 6254.9 6263.3 6628.1 6656.1 6657.4 6667.7 6733.7 5495.0 5505.2 5515.2 5556.3 5567.9 7007.8 7104.8 7151.0 7164.6 7177.8 5681.9 5709.5 5771.1 5778.0 5800.9 5798.4 5808.3 5881.8 5896.9 5902.7 6155.2 6188.5 6208.9 6246.8 6249.6 6485.0 6490.4 6699.7 6727.5 6858.6 1976.7 1986.5 2003.1 2018.6 2020.9 1490.8 1510.4 1512.3 1515.7 1518.7 5982.6 6001.7 6149.6 6152.7 6159.3 6729.4 6741.9 6806.1 6818.5 6848.8 6138.2 6158.4 6174.4 6209.6 6239.2 3572.5 3573.3 3582.9 3612.7 3632.9 7128.9 7154.4 7156.3 7176.9 7214.7 6966.6 6996.7 7052.8 7078.3 7098.3 7102.2 7105.4 7137.0 7157.0 7186.2 6743.9 6794.5 6817.6 6893.4 6904.2 6649.7 6747.9 6758.3 6818.1 6845.4 7012.5 7047.5 7128.7 7134.4 7173.1 5200.6 5218.7 5218.8 5252.5 5263.9 6818.7 6839.6 6863.3 6909.3 6920.2 6608.4 6636.9 6663.7 6665.9 6670.7 6498.9 6566.4 6569.2 6598.8 6634.3 6421.7 6423.8 6534.4 6603.7 6627.2 6192.3 6404.5 6522.7 6644.3 6667.9 6349.9 6380.6 6404.6 6425.7 6504.3 04:16:00 INFO - PID 15297 | 04:16:00 INFO - PID 15297 | [#5] yui.html Cycles:180 Average:29284.75 Median:20491.39 stddev:43062.18 (210.1%) stddev-sans-first:43130.52 04:16:00 INFO - PID 15297 | Values: 974.4 980.9 1002.1 1002.7 1013.1 23558.9 25794.9 25835.4 25854.4 25880.9 21840.8 22859.0 23133.3 23347.1 23354.5 1065.0 1087.7 1088.6 1088.8 1089.4 1103.2 1109.3 1113.1 1115.1 1117.4 1155.8 1159.5 1163.1 1163.9 1164.0 1105.5 1112.6 1140.3 1145.3 1145.7 825.0 826.7 829.5 830.4 831.3 21591.1 21685.7 21773.9 21787.5 21810.1 15334.8 21790.3 22323.8 22843.7 23002.8 17863.6 18003.4 18213.5 18260.6 18281.1 4003.9 4084.9 4085.2 4085.8 4087.7 159411.0 161203.6 162735.2 163041.0 163141.0 17473.5 17794.3 17815.9 17816.6 17863.5 29361.3 34253.5 34290.1 34324.3 36031.5 9658.3 9862.9 9897.0 9898.0 9906.2 4490.4 4503.2 4524.5 4555.2 4582.7 6102.6 6272.7 6303.3 6347.3 6350.9 1252.3 1267.6 1271.2 1275.7 1279.6 726.7 738.1 738.9 750.5 761.8 12725.4 13248.0 13939.6 14403.3 14468.3 718.1 730.3 738.0 738.3 743.1 5851.8 5919.6 6038.3 6096.3 6137.9 151808.2 152325.0 153526.0 153635.0 161665.0 126316.4 129971.0 130696.0 134262.0 134640.0 119254.4 119317.2 119833.0 120179.4 120772.4 11187.9 11217.6 11425.6 11708.1 11729.6 54621.0 55131.4 55621.2 55820.0 56989.4 73151.3 73589.6 73632.3 75468.6 75692.6 16147.5 19307.2 20104.1 20108.4 20108.4 21500.0 21683.2 21902.3 22356.7 22374.7 18088.0 18439.8 21174.2 21289.3 21493.4 20874.4 20993.7 21055.4 21116.8 21201.8 19008.4 19109.1 19237.0 19330.2 19415.9 13808.8 13972.2 14518.6 14755.0 14781.3 14342.9 15011.5 15323.8 15820.8 16021.9 04:16:00 INFO - PID 15297 | -------- Summary: end -------- 04:16:00 INFO - PID 15297 | 04:16:01 INFO - TEST-INFO | 15297: exit 0 04:16:01 INFO - TEST-OK | dromaeo_css | took 1108334ms 04:16:01 INFO - TEST-START | kraken 04:16:01 INFO - Initialising browser for kraken test... 04:16:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37127/getInfo.html -profile /tmp/tmpEhDdRq/profile 04:16:01 INFO - TEST-INFO | started process 15677 (/builds/slave/test/build/application/firefox/firefox http://localhost:37127/getInfo.html) 04:16:06 INFO - TEST-INFO | 15677: exit 0 04:16:07 INFO - Browser initialized. 04:16:07 INFO - Running cycle 1/1 for kraken test... 04:16:07 INFO - Using env: {'DISPLAY': ':0', 04:16:07 INFO - 'HOME': '/home/cltbld', 04:16:07 INFO - 'JSGC_DISABLE_POISONING': '1', 04:16:07 INFO - 'LANG': 'en_US.UTF-8', 04:16:07 INFO - 'LANGUAGE': 'en_US:en', 04:16:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:16:07 INFO - 'LOGNAME': 'cltbld', 04:16:07 INFO - 'MAIL': '/var/mail/cltbld', 04:16:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:16:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:16:07 INFO - 'MOZ_CRASHREPORTER': '1', 04:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:16:07 INFO - 'MOZ_NO_REMOTE': '1', 04:16:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:07 INFO - 'NO_EM_RESTART': '1', 04:16:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:07 INFO - 'PWD': '/builds/slave/test', 04:16:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:16:07 INFO - 'RUST_BACKTRACE': 'full', 04:16:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:16:07 INFO - 'SHELL': '/bin/bash', 04:16:07 INFO - 'SHLVL': '1', 04:16:07 INFO - 'TERM': 'linux', 04:16:07 INFO - 'TMOUT': '86400', 04:16:07 INFO - 'USER': 'cltbld', 04:16:07 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808', 04:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:07 INFO - '_': '/tools/buildbot/bin/python'} 04:16:07 INFO - TEST-INFO | started process 15881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEhDdRq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:07 INFO - PID 15881 | 04:16:07 INFO - PID 15881 | (/builds/slave/test/build/application/firefox/firefox:15933): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:16:07 INFO - PID 15881 | 04:16:18 INFO - PID 15881 | RSS: Main: 164032512 04:16:18 INFO - PID 15881 | 04:16:20 INFO - PID 15881 | Cycle 1(1): loaded http://localhost:37127/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37127/tests/kraken/driver.html?testName=audio-beat-detection) 04:16:21 INFO - PID 15881 | RSS: Main: 169631744 04:16:21 INFO - PID 15881 | 04:16:24 INFO - PID 15881 | Cycle 1(1): loaded http://localhost:37127/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37127/tests/kraken/driver.html?testName=audio-dft) 04:16:24 INFO - PID 15881 | RSS: Main: 170049536 04:16:24 INFO - PID 15881 | 04:16:27 INFO - PID 15881 | Cycle 1(1): loaded http://localhost:37127/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37127/tests/kraken/driver.html?testName=audio-fft) 04:16:28 INFO - PID 15881 | RSS: Main: 165203968 04:16:28 INFO - PID 15881 | 04:16:30 INFO - PID 15881 | Cycle 1(1): loaded http://localhost:37127/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37127/tests/kraken/driver.html?testName=audio-oscillator) 04:16:31 INFO - PID 15881 | RSS: Main: 166445056 04:16:31 INFO - PID 15881 | 04:16:33 INFO - PID 15881 | Cycle 1(1): loaded http://localhost:37127/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37127/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:16:33 INFO - PID 15881 | RSS: Main: 166346752 04:16:33 INFO - PID 15881 | 04:16:37 INFO - PID 15881 | Cycle 1(1): loaded http://localhost:37127/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37127/tests/kraken/driver.html?testName=imaging-darkroom) 04:16:37 INFO - PID 15881 | RSS: Main: 169263104 04:16:37 INFO - PID 15881 | 04:16:41 INFO - PID 15881 | Cycle 1(1): loaded http://localhost:37127/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37127/tests/kraken/driver.html?testName=imaging-desaturate) 04:16:41 INFO - PID 15881 | RSS: Main: 168964096 04:16:41 INFO - PID 15881 | 04:16:44 INFO - PID 15881 | Cycle 1(1): loaded http://localhost:37127/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37127/tests/kraken/driver.html?testName=json-parse-financial) 04:16:45 INFO - PID 15881 | RSS: Main: 169340928 04:16:45 INFO - PID 15881 | 04:16:46 INFO - PID 15881 | Cycle 1(1): loaded http://localhost:37127/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37127/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:16:47 INFO - PID 15881 | RSS: Main: 169209856 04:16:47 INFO - PID 15881 | 04:16:49 INFO - PID 15881 | Cycle 1(1): loaded http://localhost:37127/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37127/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:16:49 INFO - PID 15881 | RSS: Main: 169598976 04:16:49 INFO - PID 15881 | 04:16:51 INFO - PID 15881 | Cycle 1(1): loaded http://localhost:37127/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37127/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:16:52 INFO - PID 15881 | RSS: Main: 166490112 04:16:52 INFO - PID 15881 | 04:16:54 INFO - PID 15881 | Cycle 1(1): loaded http://localhost:37127/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:16:55 INFO - PID 15881 | RSS: Main: 166264832 04:16:55 INFO - PID 15881 | 04:16:58 INFO - PID 15881 | Cycle 1(1): loaded http://localhost:37127/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:16:58 INFO - PID 15881 | RSS: Main: 166567936 04:16:58 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | Cycle 1(1): loaded http://localhost:37127/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37127/tests/kraken/driver.html?testName=ai-astar) 04:17:00 INFO - PID 15881 | RSS: Main: 168366080 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | __start_tp_report 04:17:00 INFO - PID 15881 | _x_x_mozilla_page_load 04:17:00 INFO - PID 15881 | _x_x_mozilla_page_load_details 04:17:00 INFO - PID 15881 | |i|pagename|runs| 04:17:00 INFO - PID 15881 | |0;ai-astar;107;105;105;105;108;108;106;104;105;105 04:17:00 INFO - PID 15881 | |1;audio-beat-detection;112;112;111;111;112;117;112;113;115;111 04:17:00 INFO - PID 15881 | |2;audio-dft;162;162;161;163;163;162;163;163;169;162 04:17:00 INFO - PID 15881 | |3;audio-fft;73;73;73;72;76;73;75;73;73;74 04:17:00 INFO - PID 15881 | |4;audio-oscillator;79;79;77;81;82;77;83;83;82;79 04:17:00 INFO - PID 15881 | |5;imaging-gaussian-blur;113;117;113;110;113;113;114;117;117;114 04:17:00 INFO - PID 15881 | |6;imaging-darkroom;149;157;148;153;149;148;149;150;151;152 04:17:00 INFO - PID 15881 | |7;imaging-desaturate;98;94;93;99;99;94;98;94;94;100 04:17:00 INFO - PID 15881 | |8;json-parse-financial;50;48;44;44;45;48;45;43;46;45 04:17:00 INFO - PID 15881 | |9;json-stringify-tinderbox;38;38;38;38;39;38;38;37;38;38 04:17:00 INFO - PID 15881 | |10;stanford-crypto-aes;78;74;71;69;71;72;73;73;71;72 04:17:00 INFO - PID 15881 | |11;stanford-crypto-ccm;103;108;109;108;111;104;103;114;111;103 04:17:00 INFO - PID 15881 | |12;stanford-crypto-pbkdf2;154;156;156;152;164;154;152;150;153;153 04:17:00 INFO - PID 15881 | |13;stanford-crypto-sha256-iterative;68;58;58;60;60;61;62;58;62;62 04:17:00 INFO - PID 15881 | __end_tp_report 04:17:00 INFO - PID 15881 | __start_cc_report 04:17:00 INFO - PID 15881 | _x_x_mozilla_cycle_collect,871 04:17:00 INFO - PID 15881 | __end_cc_report 04:17:00 INFO - PID 15881 | __startTimestamp1505215020768__endTimestamp 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | ------- Summary: start ------- 04:17:00 INFO - PID 15881 | Number of tests: 14 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | [#0] ai-astar Cycles:10 Average:105.80 Median:105.50 stddev:1.40 (1.3%) stddev-sans-first:1.41 04:17:00 INFO - PID 15881 | Values: 107.0 105.0 105.0 105.0 108.0 108.0 106.0 104.0 105.0 105.0 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | [#1] audio-beat-detection Cycles:10 Average:112.60 Median:112.00 stddev:1.96 (1.7%) stddev-sans-first:2.06 04:17:00 INFO - PID 15881 | Values: 112.0 112.0 111.0 111.0 112.0 117.0 112.0 113.0 115.0 111.0 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:2.21 (1.4%) stddev-sans-first:2.32 04:17:00 INFO - PID 15881 | Values: 162.0 162.0 161.0 163.0 163.0 162.0 163.0 163.0 169.0 162.0 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | [#3] audio-fft Cycles:10 Average:73.50 Median:73.00 stddev:1.18 (1.6%) stddev-sans-first:1.24 04:17:00 INFO - PID 15881 | Values: 73.0 73.0 73.0 72.0 76.0 73.0 75.0 73.0 73.0 74.0 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:81.50 stddev:2.30 (2.8%) stddev-sans-first:2.40 04:17:00 INFO - PID 15881 | Values: 79.0 79.0 77.0 81.0 82.0 77.0 83.0 83.0 82.0 79.0 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:2.28 (2.0%) stddev-sans-first:2.39 04:17:00 INFO - PID 15881 | Values: 113.0 117.0 113.0 110.0 113.0 113.0 114.0 117.0 117.0 114.0 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:150.50 stddev:2.80 (1.9%) stddev-sans-first:2.91 04:17:00 INFO - PID 15881 | Values: 149.0 157.0 148.0 153.0 149.0 148.0 149.0 150.0 151.0 152.0 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:2.71 (2.8%) stddev-sans-first:2.80 04:17:00 INFO - PID 15881 | Values: 98.0 94.0 93.0 99.0 99.0 94.0 98.0 94.0 94.0 100.0 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | [#8] json-parse-financial Cycles:10 Average:45.80 Median:45.50 stddev:2.20 (4.8%) stddev-sans-first:1.73 04:17:00 INFO - PID 15881 | Values: 50.0 48.0 44.0 44.0 45.0 48.0 45.0 43.0 46.0 45.0 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.47 (1.2%) stddev-sans-first:0.50 04:17:00 INFO - PID 15881 | Values: 38.0 38.0 38.0 38.0 39.0 38.0 38.0 37.0 38.0 38.0 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:72.50 stddev:2.41 (3.3%) stddev-sans-first:1.48 04:17:00 INFO - PID 15881 | Values: 78.0 74.0 71.0 69.0 71.0 72.0 73.0 73.0 71.0 72.0 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | [#11] stanford-crypto-ccm Cycles:10 Average:107.40 Median:108.50 stddev:3.98 (3.7%) stddev-sans-first:3.89 04:17:00 INFO - PID 15881 | Values: 103.0 108.0 109.0 108.0 111.0 104.0 103.0 114.0 111.0 103.0 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:154.00 stddev:3.84 (2.5%) stddev-sans-first:4.07 04:17:00 INFO - PID 15881 | Values: 154.0 156.0 156.0 152.0 164.0 154.0 152.0 150.0 153.0 153.0 04:17:00 INFO - PID 15881 | 04:17:00 INFO - PID 15881 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.90 Median:61.50 stddev:3.00 (4.9%) stddev-sans-first:1.76 04:17:00 INFO - PID 15881 | Values: 68.0 58.0 58.0 60.0 60.0 61.0 62.0 58.0 62.0 62.0 04:17:00 INFO - PID 15881 | -------- Summary: end -------- 04:17:00 INFO - PID 15881 | 04:17:01 INFO - PID 15881 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:17:01 INFO - TEST-INFO | 15881: exit 0 04:17:01 INFO - TEST-OK | kraken | took 60161ms 04:17:01 INFO - SUITE-END | took 1168s 04:17:01 INFO - Completed test suite (00:19:28) 04:17:01 INFO - javascript benchmark 04:17:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9150.003608635663, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3864.86472973446, 3872.6514613684767, 3873.980630096849, 3894.221155768845, 3899.7855117968534, 6076.544259180557, 6112.541559383042, 6199.132121502993, 6214.782482613109, 6230.408111229432, 6207.193064901568, 6216.84457888553, 6240.84397890053, 6263.7494500220055, 6267.0, 5546.168074788794, 5555.666660000393, 5598.076317407623, 5602.7758889644565, 5694.77220911163, 5657.038303488396, 5677.48902598766, 5691.345495268056, 5746.0, 5748.45389687979, 5684.488396044355, 5692.345380281258, 5722.856928576777, 5766.106253530709, 5782.971085144568, 5466.9179962300595, 5549.278593782782, 5636.436356364372, 5673.8581535461535, 5699.68651724155, 5538.280023596947, 5587.189857470685, 5634.126710359901, 5673.12066629669, 5687.573431992617, 6018.067199584071, 6105.114758360013, 6185.195924529828, 6220.87558248837, 6244.750209991595, 6738.52830301879, 6781.593104413751, 6805.6597170141295, 6831.931680683179, 6846.144231971004, 6814.250432452426, 6841.144856892888, 6854.280300568468, 6915.031895534629, 6934.202566704793, 6289.685515724195, 6340.080688300217, 6377.107204991305, 6409.391107844747, 6422.261439934374, 6943.965280173667, 6995.965020174866, 7018.964905175543, 7026.894596581055, 7043.436525077981, 6607.603543787388, 6651.66741662915, 6685.231198412148, 6742.629155396402, 6779.559328643622, 6588.04473351371, 6690.665466726644, 6772.322767723287, 6851.931480685129, 6860.0738900247825, 6683.6324002180345, 6725.630090345078, 6743.662816859138, 6762.087118239073, 6770.593764374154, 6775.559588626724, 6777.186737591422, 6832.0, 6870.45036397087, 6872.209695885037, 4824.179889418807, 4967.178322886319, 5009.724465154379, 5030.647854650139, 5046.318746969112, 4456.487503937024, 4487.820487180476, 4492.303692927601, 4499.662525310615, 4515.435570553681, 6106.480949119375, 6130.693465326805, 6131.601445906002, 6138.416850399205, 6197.25632924052, 6664.333566643297, 6729.1252137221845, 6763.661816909135, 6838.48711346651, 6853.109095817512, 5981.850453738604, 6119.173911521976, 6184.5980011299125, 6186.505079593621, 6196.659183744938, 5403.756830942617, 5420.430854760272, 5478.726063696799, 5479.6164268500825, 5498.780048798003, 6960.860782784316, 7023.719051237996, 7029.0, 7045.506814523037, 7063.646817659096, 6590.703418346282, 6618.536702430783, 6624.138861948012, 6662.700178492077, 6699.062131301719, 7042.471814614027, 7107.75122870697, 7110.85778284421, 7127.216006239413, 7142.714291428285, 6694.531382803157, 6775.322467753185, 6783.3555812197765, 6784.728610855511, 6787.660616969033, 6721.294264102395, 6787.321267873173, 6809.897851532132, 6899.103116595012, 6907.309269073053, 6367.87264254703, 6491.026346048131, 6543.934560654523, 6621.867562648817, 6622.503312251697, 6533.509986751108, 6553.5084868634085, 6565.244996825426, 6571.507136964842, 6587.901181482186, 6394.808155755335, 6425.614463132227, 6429.0, 6448.935510644834, 6514.022896565363, 6407.391297826699, 6422.614643121427, 6485.416312531895, 6560.245571759118, 6679.298673639198, 6371.490280777434, 6397.3282805306635, 6399.616023038632, 6411.903821442589, 6417.422431981144], "value": 6178.587788014866, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [927.1516562345454, 940.2900809888533, 961.0581630002597, 992.8758905136858, 1000.5197505197505, 42112.0, 42745.35881961773, 42936.35595466063, 42982.0, 43023.35464968028, 40553.39169912446, 41112.17775644486, 41226.175476490454, 41275.79362103193, 41294.7935260324, 7306.232845551221, 7368.631568421584, 7380.966664666951, 7447.702091916317, 7451.7019319227165, 7285.817854553626, 7342.743003994861, 7359.4480413968895, 7363.705451781922, 7400.296971787671, 7916.366690664733, 8104.5542495162745, 8106.837863242732, 8107.716229931953, 8107.878381824277, 8006.719764808233, 8035.276825085741, 8064.072631647318, 8067.717629882955, 8071.354291656653, 7761.417893657942, 7982.32150267228, 7982.722764357675, 7984.161663025415, 7991.041075071029, 37934.241315173545, 38270.42594361059, 38323.808380958195, 38362.80818595889, 38369.0, 3745.0824547985644, 3790.639889210521, 3791.9241615167543, 3794.544654641433, 3796.126890815128, 32886.177845553815, 33010.504842427385, 33112.33775324504, 33189.33621327584, 33269.667303326896, 5400.324959380077, 5400.405955344909, 5422.0511410503, 5422.40353561108, 5440.483154100394, 214709.0, 215890.0, 216225.0, 216516.0, 216689.0, 50929.0, 51097.744511277946, 51261.48738512567, 51520.48479515157, 51656.483435165916, 54311.0, 54664.18003729947, 54774.72612636911, 54817.0, 54944.72527637416, 16760.413385531447, 17106.144692765312, 17138.742918856227, 17146.91426542884, 17148.828511714724, 13876.167429954236, 13893.235872027135, 13893.513727019506, 13919.164850109026, 13940.233287169303, 15119.16844573559, 15315.463958761613, 15368.0, 15392.0, 15444.845551544566, 5946.910796338058, 6036.547258955596, 6082.361352058058, 6196.194494715748, 6346.174997250328, 1088.482970588964, 1089.8801131875487, 1092.3391348234363, 1106.9446527673583, 1108.5288752280248, 25135.497290054096, 25202.621960670604, 25497.490050198892, 25598.10406635796, 25612.0, 1203.085654902263, 1204.5362535423924, 1207.8067509198486, 1212.672578403826, 1212.9514819407125, 13329.0, 13425.26161061151, 13500.459981600823, 13525.864741352658, 13780.931095344458, 265357.0, 268434.0, 283786.0, 284994.0, 286420.0, 49923.0, 50571.241431378556, 54501.45498545043, 56478.152827707614, 57567.712161438925, 1507.366905899525, 1518.772184172361, 1532.1037193241855, 1532.4176812811284, 1535.1786794065122, 30208.54687179738, 30490.390192195588, 30591.54112688267, 30612.0, 30817.229569260948, 39975.20049598934, 40063.39904901487, 40221.1955760889, 40256.79871600623, 40394.0, 231421.0, 231506.0, 231634.0, 232191.0, 232804.0, 34927.12682182864, 34948.30103397969, 34991.65008349884, 35250.64749352474, 35285.64714352824, 44404.777976109915, 45392.0, 46019.539804601525, 46065.0, 46174.53825461702, 34040.48939265963, 34157.31685366329, 34570.30859382748, 34856.47715284323, 34993.82503087468, 33903.0, 34154.48768268528, 34319.828400857834, 34912.0, 34935.825320873235, 39840.800795995834, 39846.60153398429, 40098.59901401065, 40335.1932961345, 40469.0, 33529.66470335265, 33615.0, 33760.324793504486, 33810.0, 34146.31707365889, 25093.498130037664, 25946.74053259443, 26103.0, 26408.471830563667, 26544.0], "value": 18382.973100709296, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.2974164839612, 608.9878202435954, 609.2354095610009, 617.901135818269, 628.8993760998242, 23179.884100579493, 23750.287491375242, 23765.762342376573, 23778.5244295114, 23876.0, 24481.632775508337, 26164.86917565414, 26288.21135365937, 26355.604665930026, 26425.339366515847, 6645.867082658344, 6828.078209441736, 6829.180498340206, 6838.692258848364, 6854.074699915497, 6468.191476065492, 6724.361185687377, 6726.394624483795, 6728.259891411941, 6759.797206083801, 6691.330866913294, 6692.765753198639, 6702.162229721285, 6705.832354191136, 6709.765158219463, 6681.632510211936, 6692.196936367618, 6692.9330706693045, 6698.83252918681, 6714.731410743613, 6240.781572644981, 6245.906311405332, 6266.436020758154, 6280.528960327993, 6292.024736165901, 29313.70686293131, 29414.26464338387, 30374.696253037408, 30492.08523744269, 30502.694973050428, 2209.8784566848976, 2248.4828489447355, 2253.233900473847, 2254.1546919905036, 2254.6843441918145, 20086.296979605642, 20681.68977465339, 20690.379288621367, 20699.689504657443, 20759.58480830375, 2514.949701005988, 2532.632768248612, 2575.6780402449695, 2593.286846117314, 2624.9606255905987, 130161.34919325342, 136085.0, 136158.0, 143204.0, 150236.9999999989, 15502.30239639219, 15986.60033499172, 16150.19249037567, 16274.349026038826, 16657.750133748003, 24933.252002439956, 25038.248852534452, 25038.749612504005, 25079.498410031698, 25086.0, 10799.298045627009, 10905.345679259111, 10943.124550035978, 11010.339379637247, 11039.448027598748, 10061.346012509164, 10063.446510441996, 10071.848922266172, 10137.442440665835, 10148.543315550818, 9787.608495660237, 9811.607535698635, 9855.476231934586, 10095.141912937335, 10124.038216369434, 2890.7109289070922, 2917.460269850042, 2961.644602647696, 2970.1089673097986, 3013.9547906781418, 1035.4460363705382, 1053.2416660004785, 1054.2620165883911, 1055.7307886488895, 1056.7252514346326, 20759.792402076087, 21240.362789116352, 21339.35981920545, 21650.0, 21801.236956706438, 1093.6008356949815, 1119.7200699825044, 1127.2560110327145, 1128.2497139402205, 1139.703677043958, 11570.3717763647, 11636.010939070104, 11820.645380638594, 11882.0, 11912.285262884254, 542352.0, 544846.0, 550026.0, 569477.0, 570152.0, 132454.0, 137109.3144534271, 138370.0, 138821.0, 142409.0, 1095.6274866545414, 1136.579465597734, 1203.6810245285008, 1210.5036934856666, 1265.4432049898016, 21579.057675225875, 22001.11995520161, 22073.558528829013, 22120.115195392005, 22192.334229973127, 63123.6843815778, 63170.36829631829, 63251.0, 64040.7191856151, 66730.0, 82858.5857070735, 82961.58519207606, 83542.0, 83556.58221708852, 83851.0, 15052.774208387102, 15238.619034524225, 15443.150626715638, 15457.458988935334, 15673.294701738221, 24078.87960560186, 24281.39296517601, 24283.39291517726, 24357.26928192157, 24506.142285019938, 19082.904585476983, 19411.126499307284, 19741.111649975497, 19833.50416239548, 19838.801611983694, 17494.125293735007, 17503.0, 17640.1179941005, 18104.366347177787, 18164.09179541044, 19302.61394772125, 19974.10116544788, 19998.100085496477, 20078.397648070582, 20246.898765506077, 12611.432485538357, 14467.78298325547, 15061.698766024838, 15106.39574417011, 15127.243637817845, 19355.709664355327, 19440.8055919439, 19726.901365493082, 19879.900600496905, 19881.204751809764], "value": 12801.978273514156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.319233575548, 1476.0922032949732, 1481.8814494840415, 1483.0656686287637, 1495.2150121186376, 16301.266443010063, 16869.91565042176, 16870.409535666255, 16902.07038612876, 16921.238544265507, 16675.583110422245, 16682.58293542659, 16727.0, 16730.24713887875, 16820.74768878468, 2774.0, 2787.1499192746205, 2811.704770999046, 2825.8163219390776, 2829.5472724364104, 2801.355688191717, 2818.9436211275865, 2833.5183018886737, 2839.843808590527, 2841.3891013432108, 2699.1362763915554, 2704.8241864278757, 2939.941201175986, 2940.2355387599273, 2940.558916162582, 2788.0659978907092, 2802.299425143714, 2820.858957052139, 2833.235026542832, 2833.943321133576, 2696.7842572594145, 2793.385455199853, 2800.1179628417185, 2803.523401021831, 2804.2288370698016, 16291.103989280586, 16360.754588681179, 16476.0, 16514.0, 16524.75212871808, 8237.958810205912, 8554.0, 8568.528730919797, 8574.35692323072, 8577.914220857836, 5599.384067752544, 5757.884842303172, 5797.0, 5873.2952045754355, 5889.911651325234, 2045.1103769860158, 2046.4576887124774, 2047.3346162497098, 2053.065855035955, 2093.0790452201136, 30073.0, 30336.089917302517, 30378.54432183519, 30472.54291185634, 30492.0, 7183.92816071843, 7221.602811845399, 7252.129744430702, 7339.752242118852, 7346.853062938711, 19576.21695132179, 19581.0, 19612.803871961383, 19695.60608787816, 19712.21151153938, 8563.186497282748, 8703.086175951561, 8780.209781119729, 8801.735947921572, 8802.295816334678, 7712.383009359238, 7777.261160189773, 7815.882761758578, 7874.72438464651, 7884.487508311941, 5491.835244942658, 5646.604737668324, 5669.858253543612, 5687.232223649837, 5755.3381361143165, 1626.1786798785436, 1640.958976025609, 1642.1624971264741, 1648.620817212024, 1656.8840181187202, 968.1286841842398, 974.3715303629119, 981.8969008254173, 983.3952119446488, 1009.1825621246813, 9150.084991500797, 9238.722838314861, 9266.721998340061, 9351.064893510595, 9363.578638961262, 768.2394429514852, 796.3469954637142, 807.075898096676, 812.1391325195311, 819.7376839411331, 5465.207544905967, 5688.715564221772, 5723.77104915807, 5734.111212762028, 5825.883482330414, 24718.629220561706, 25504.489910201693, 25629.743702562737, 25660.10189643391, 25771.871140644176, 24149.0, 25133.62299565508, 25141.24576262715, 25183.496330073664, 25272.36819079501, 12366.876331236572, 12829.0, 12867.42096605655, 12891.935540322425, 12905.612831614879, 9148.679796207101, 9212.539373031455, 9276.72169834906, 9289.34974551775, 9311.487868167316, 20802.79197208069, 21159.365219043455, 21204.15183392647, 21471.355859324245, 21499.0, 21839.235626752987, 21914.23300184486, 22105.0, 22125.446863828533, 22251.554968900855, 12303.44634491432, 12312.445939932546, 12436.751264974831, 12440.19138755978, 12520.624381268577, 15542.30059647296, 15811.0, 15816.0, 15823.762643560125, 15840.128792916501, 11716.472758725708, 11781.293122412682, 11886.108541859223, 11887.0, 12038.03695704359, 12513.249205047727, 12597.685057873627, 12636.0, 12673.873261267268, 12765.170263932814, 10769.676909692722, 10988.0, 11067.059299959594, 11079.61221357281, 11102.777944441228, 8313.625886834985, 8356.080831108695, 8367.790805229675, 8448.366372522209, 8490.617922193393, 8452.535110568977, 8533.146685331418, 8557.0, 8557.57212139403, 8697.173768491983], "value": 7286.406612802071, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.3197109742882, 563.7519491423773, 569.1320735877787, 576.0984059946184, 594.9970250148749, 6147.508199344053, 6199.256089269288, 6238.594491358064, 6383.138276332694, 6393.584417012902, 6282.717277722502, 6305.4009869062365, 6307.306196318401, 6353.745850165988, 6373.776917807878, 5213.973930130344, 5216.452272511388, 5232.398274198459, 5253.8949221015555, 5255.789768409259, 5085.211792172219, 5242.8689282767855, 5243.187305967581, 5257.342832145981, 5276.604254680914, 5200.997615917861, 5207.4792520748, 5210.843674689765, 5216.6869987800665, 5227.294315267447, 5214.400343960437, 5229.790808367661, 5235.057689615886, 5283.815066472655, 5308.336457942757, 4992.725400102993, 5004.099262132815, 5009.348784657971, 5018.272350509155, 5035.370578677665, 6137.0, 6201.317855035987, 6254.061890716429, 6297.118403423525, 6355.777547785805, 6166.691665416712, 6233.96883015582, 6242.531810114214, 6254.874902501924, 6263.279722831841, 6628.138342015555, 6656.106177885942, 6657.40083392497, 6667.733290668368, 6733.663316834188, 5495.0, 5505.229267902497, 5515.227868098469, 5556.305326875301, 5567.858588989247, 7007.789766307019, 7104.822379440504, 7150.964245178793, 7164.641767911584, 7177.784666460015, 5681.857953551112, 5709.457601527848, 5771.105478650816, 5778.017736984639, 5800.854978625568, 5798.391168927286, 5808.273965754281, 5881.764729410861, 5896.882062358729, 5902.734376953047, 6155.169052177988, 6188.504919606421, 6208.906866397007, 6246.75012999484, 6249.562530622813, 6485.0, 6490.350964903472, 6699.732010719614, 6727.461803055744, 6858.588484690935, 1976.7034944758402, 1986.4636548131923, 2003.058562475634, 2018.6265540874692, 2020.8989550522415, 1490.7912892195102, 1510.3731951240113, 1512.3043400036106, 1515.6665533582593, 1518.7342215112312, 5982.551308651869, 6001.699915004232, 6149.600275982047, 6152.723127459186, 6159.291681456601, 6729.360710732571, 6741.898871516931, 6806.149231346082, 6818.522703410813, 6848.794536163923, 6138.202033735586, 6158.351908679311, 6174.413430724074, 6209.627422354673, 6239.1577137085915, 3572.464130380412, 3573.285342931424, 3582.8566857325936, 3612.692921101736, 3632.927341453209, 7128.893066604005, 7154.35610795031, 7156.320149585781, 7176.892346614805, 7214.747483838146, 6966.582005079711, 6996.705609462266, 7052.823679408056, 7078.292170782881, 7098.273406461546, 7102.218755936843, 7105.396041336441, 7136.964315178391, 7157.033800436874, 7186.209516953131, 6743.865122697421, 6794.524383293122, 6817.625030623165, 6893.448524118159, 6904.240533541407, 6649.667516624053, 6747.865042699217, 6758.290379510081, 6818.113645226089, 6845.418139458003, 7012.493753123438, 7047.541909775849, 7128.6792094356915, 7134.429245660439, 7173.1392232932385, 5200.557952573922, 5218.66078704883, 5218.843434696965, 5252.501012403815, 5263.89472210546, 6818.727250909908, 6839.640324088182, 6863.2793556677825, 6909.2745261748805, 6920.238773734784, 6608.43828274602, 6636.933630663631, 6663.733450662113, 6665.900011499928, 6670.733170673313, 6498.935010649833, 6566.376194261537, 6569.178852643419, 6598.769043083469, 6634.341414646338, 6421.71102300407, 6423.807285781434, 6534.444572211415, 6603.669816509059, 6627.1716035495565, 6192.287886892885, 6404.487640988803, 6522.695460907743, 6644.269130395556, 6667.933320666732, 6349.904751428639, 6380.617162970237, 6404.551681382259, 6425.710843012169, 6504.284528701934], "value": 5351.191441694886, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [974.3715303629159, 980.9400259455143, 1002.1481740520559, 1002.7292630989638, 1013.0679774607361, 23558.88220558899, 25794.87102564487, 25835.354116147104, 25854.35364115898, 25880.870595647044, 21840.781592184074, 22858.99999999996, 23133.30600081996, 23347.066117355327, 23354.532909341804, 1064.9574017039308, 1087.7171935296801, 1088.5645741703304, 1088.8149014667526, 1089.3681664634532, 1103.2442776697987, 1109.2623405435415, 1113.1261959361902, 1115.0577761791274, 1117.4412793603199, 1155.7515134246134, 1159.5187996981285, 1163.081165878959, 1163.8894305041008, 1163.9534418623246, 1105.5135740274254, 1112.6161474291357, 1140.321508702325, 1145.34715212329, 1145.6792098212472, 824.9587520624004, 826.7023871406288, 829.4857188543082, 830.4228561150003, 831.2601784411878, 21591.1363545458, 21685.67471487929, 21773.891130544245, 21787.455313617127, 21810.127594896185, 15334.846651533453, 21790.346289611178, 22323.776762232334, 22843.657345139836, 23002.76997230023, 17863.553411164823, 18003.369882054198, 18213.45359639213, 18260.634787304178, 18281.085945702795, 4003.939940900889, 4084.9387259191135, 4085.20338533986, 4085.775282359469, 4087.693422993287, 159411.0, 161203.5518579267, 162735.1863240688, 163041.0, 163141.0, 17473.47579572615, 17794.288228470974, 17815.910920445316, 17816.643667126584, 17863.46409607714, 29361.265968350534, 34253.486197707054, 34290.14274643104, 34324.313513730085, 36031.4595281071, 9658.323917325719, 9862.852057219148, 9897.0, 9897.950510247547, 9906.207503399855, 4490.416245888014, 4503.166914120898, 4524.524924882906, 4555.2256116460285, 4582.679212455096, 6102.603330783485, 6272.717727702173, 6303.3066362700065, 6347.270063942613, 6350.936490635035, 1252.2549083295426, 1267.5626908716479, 1271.211848653822, 1275.655572995286, 1279.584135156078, 726.672997151284, 738.1363804348817, 738.9408847292203, 750.5234176297981, 761.7981234972737, 12725.363731813557, 13247.972172661415, 13939.581812545639, 14403.279836008367, 14468.27658617086, 718.0557566799641, 730.3098571849551, 738.0368618952318, 738.3391864281546, 743.0971369785736, 5851.795187168429, 5919.644821310735, 6038.275406951194, 6096.329403765582, 6137.925862974051, 151808.2409587945, 152325.0, 153526.0, 153635.0, 161665.0, 126316.36841815732, 129971.0, 130696.0, 134262.0, 134640.0, 119254.40372798254, 119317.22731090659, 119833.0, 120179.39910300393, 120772.39613801875, 11187.944060279646, 11217.60738374153, 11425.60010399632, 11708.121890858049, 11729.589464368706, 54621.0, 55131.44868551263, 55621.16568251399, 55820.0, 56989.43010569841, 73151.26848731445, 73589.63205183939, 73632.26367736468, 75468.62265688636, 75692.62153689197, 16147.515574532783, 19307.227710891406, 20104.095315710536, 20108.39674809758, 20108.39674809758, 21500.0, 21683.241086561895, 21902.342929712133, 22356.664650029936, 22374.664380033988, 18088.00515971634, 18439.81560184381, 21174.153033878472, 21289.254876079263, 21493.355199344045, 20874.37376878696, 20993.685094723896, 21055.368338949855, 21116.78883211148, 21201.787982119982, 19008.42974710761, 19109.140088695764, 19237.03814809282, 19330.22679092877, 19415.902920485307, 13808.792868107188, 13972.231527266098, 14518.637034074232, 14755.040922340013, 14781.260936953324, 14342.928285358506, 15011.47459838944, 15323.770143447635, 15820.841791581937, 16021.919890400473], "value": 10350.369882968444, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1375.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 105.0, 105.0, 105.0, 108.0, 108.0, 106.0, 104.0, 105.0, 105.0], "value": 105.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 111.0, 111.0, 112.0, 117.0, 112.0, 113.0, 115.0, 111.0], "value": 112.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 163.0, 162.0, 163.0, 163.0, 169.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 72.0, 76.0, 73.0, 75.0, 73.0, 73.0, 74.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 77.0, 81.0, 82.0, 77.0, 83.0, 83.0, 82.0, 79.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 113.0, 110.0, 113.0, 113.0, 114.0, 117.0, 117.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 157.0, 148.0, 153.0, 149.0, 148.0, 149.0, 150.0, 151.0, 152.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 93.0, 99.0, 99.0, 94.0, 98.0, 94.0, 94.0, 100.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 44.0, 44.0, 45.0, 48.0, 45.0, 43.0, 46.0, 45.0], "value": 45.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 37.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 71.0, 69.0, 71.0, 72.0, 73.0, 73.0, 71.0, 72.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 108.0, 109.0, 108.0, 111.0, 104.0, 103.0, 114.0, 111.0, 103.0], "value": 107.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 156.0, 152.0, 164.0, 154.0, 152.0, 150.0, 153.0, 153.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 58.0, 58.0, 60.0, 60.0, 61.0, 62.0, 58.0, 62.0, 62.0], "value": 60.9, "unit": "score"}]}]} 04:17:02 INFO - Return code: 0 04:17:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:17:02 INFO - # TBPL SUCCESS # 04:17:02 INFO - Running post-action listener: _package_coverage_data 04:17:02 INFO - Running post-action listener: _resource_record_post_action 04:17:02 INFO - [mozharness: 2017-09-12 11:17:02.061978Z] Finished run-tests step (success) 04:17:02 INFO - Running post-run listener: _resource_record_post_run 04:17:02 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 143360; Write bytes: 294285312; Read time: 28; Write time: 256060 04:17:02 INFO - TinderboxPrint: CPU usage
13.1% 04:17:02 INFO - TinderboxPrint: I/O read bytes / time
143,360 / 28 04:17:02 INFO - TinderboxPrint: I/O write bytes / time
294,285,312 / 256,060 04:17:02 INFO - TinderboxPrint: CPU idle
8,217.5 (86.9%) 04:17:02 INFO - TinderboxPrint: CPU user
1,188.3 (12.6%) 04:17:02 INFO - TinderboxPrint: Swap in / out
0 / 0 04:17:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 11411456; Read time: 0; Write time: 768 04:17:02 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:17:02 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 143360; Write bytes: 282472448; Read time: 28; Write time: 255252 04:17:02 INFO - Running post-run listener: _upload_blobber_files 04:17:02 INFO - Blob upload gear active. 04:17:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:17:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:17:03 INFO - (blobuploader) - INFO - Open directory for files ... 04:17:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:17:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:17:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:04 INFO - (blobuploader) - INFO - Done attempting. 04:17:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:17:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:17:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:11 INFO - (blobuploader) - INFO - Done attempting. 04:17:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:17:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:17:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:12 INFO - (blobuploader) - INFO - Done attempting. 04:17:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:17:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:17:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:13 INFO - (blobuploader) - INFO - Done attempting. 04:17:13 INFO - (blobuploader) - INFO - Iteration through files over. 04:17:13 INFO - Return code: 0 04:17:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:17:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:17:13 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/092dcf60f0fdca2d3aa4125b9d1abb3183f396d8ae70b75b404c1c7499cd9c4d2e86fd1d99758b8a2a988c0c0e93ad88c60d8da98428f52f4112c528281c45e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ca08eb9ea9d10ff3dc78421eeb6dce726c6f596e1b47741ee657c64dcacf78c3dc48c46cce5b8e26532540bde1eb9502289b83f3b1a209c442ef9ba19df8f4b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97dd30a4a03a34997c3d02cff6246c05d5d0ecb1797aec0ce1fedbe5a0cb86b23b7c540a72ee434e4745362bd2c238346c0ebc2e58821760ed3ee919c3363605", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45c8385223fb9656c261d2eede523a7923652b61e74285111afe4569fde939b5cfb118eff8613a15b5feacd43439313d76d684c856b5e7b69e98dedd003eb475"} 04:17:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:17:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:17:13 INFO - Contents: 04:17:13 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/092dcf60f0fdca2d3aa4125b9d1abb3183f396d8ae70b75b404c1c7499cd9c4d2e86fd1d99758b8a2a988c0c0e93ad88c60d8da98428f52f4112c528281c45e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ca08eb9ea9d10ff3dc78421eeb6dce726c6f596e1b47741ee657c64dcacf78c3dc48c46cce5b8e26532540bde1eb9502289b83f3b1a209c442ef9ba19df8f4b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97dd30a4a03a34997c3d02cff6246c05d5d0ecb1797aec0ce1fedbe5a0cb86b23b7c540a72ee434e4745362bd2c238346c0ebc2e58821760ed3ee919c3363605", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45c8385223fb9656c261d2eede523a7923652b61e74285111afe4569fde939b5cfb118eff8613a15b5feacd43439313d76d684c856b5e7b69e98dedd003eb475"} 04:17:13 INFO - Running post-run listener: copy_logs_to_upload_dir 04:17:13 INFO - Copying logs to upload dir... 04:17:13 INFO - mkdir: /builds/slave/test/build/upload/logs 04:17:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.703506 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-12 04:17:13.267511) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 04:17:13.270815) ========= 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=930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/092dcf60f0fdca2d3aa4125b9d1abb3183f396d8ae70b75b404c1c7499cd9c4d2e86fd1d99758b8a2a988c0c0e93ad88c60d8da98428f52f4112c528281c45e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ca08eb9ea9d10ff3dc78421eeb6dce726c6f596e1b47741ee657c64dcacf78c3dc48c46cce5b8e26532540bde1eb9502289b83f3b1a209c442ef9ba19df8f4b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97dd30a4a03a34997c3d02cff6246c05d5d0ecb1797aec0ce1fedbe5a0cb86b23b7c540a72ee434e4745362bd2c238346c0ebc2e58821760ed3ee919c3363605", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45c8385223fb9656c261d2eede523a7923652b61e74285111afe4569fde939b5cfb118eff8613a15b5feacd43439313d76d684c856b5e7b69e98dedd003eb475"} build_url:https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011477 build_url: 'https://queue.taskcluster.net/v1/task/ZYGHapDoTCuRA26NgxMAoA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/092dcf60f0fdca2d3aa4125b9d1abb3183f396d8ae70b75b404c1c7499cd9c4d2e86fd1d99758b8a2a988c0c0e93ad88c60d8da98428f52f4112c528281c45e2", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ca08eb9ea9d10ff3dc78421eeb6dce726c6f596e1b47741ee657c64dcacf78c3dc48c46cce5b8e26532540bde1eb9502289b83f3b1a209c442ef9ba19df8f4b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/97dd30a4a03a34997c3d02cff6246c05d5d0ecb1797aec0ce1fedbe5a0cb86b23b7c540a72ee434e4745362bd2c238346c0ebc2e58821760ed3ee919c3363605", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45c8385223fb9656c261d2eede523a7923652b61e74285111afe4569fde939b5cfb118eff8613a15b5feacd43439313d76d684c856b5e7b69e98dedd003eb475"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 04:17:13.300053) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 04:17:13.300479) ========= 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=930c87414c89fc706ee2024c000001c6-1505213146.34903-547678808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 04:17:13.385854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 04:17:13.386258) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 04:17:13.386666) ========= ========= Total master_lag: 0.20 =========