builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1503320249.18 results: success (0) revision: c7c96eebbcb91e5e0c8ef0dbbb5324812fa1e476 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 05:57:29.184144) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 05:57:29.184571) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 05:57:29.184839) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 05:57:29.198137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:57:29.198402) ========= 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=8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-21 05:57:29-- 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% 228M=0s 2017-08-21 05:57:29 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118698 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:57:29.331874) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:57:29.335194) ========= 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=8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019679 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:57:29.384769) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:57:29.385079) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c7c96eebbcb91e5e0c8ef0dbbb5324812fa1e476 --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 c7c96eebbcb91e5e0c8ef0dbbb5324812fa1e476 --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=8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-21 05:57:29,409 truncating revision to first 12 chars 2017-08-21 05:57:29,409 Setting DEBUG logging. 2017-08-21 05:57:29,410 attempt 1/10 2017-08-21 05:57:29,410 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c7c96eebbcb9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-21 05:57:30,018 unpacking tar archive at: mozilla-central-c7c96eebbcb9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.887199 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:57:30.289533) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 05:57:30.289846) ========= script_repo_revision: c7c96eebbcb91e5e0c8ef0dbbb5324812fa1e476 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 05:57:30.293351) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 05:57:30.293827) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 05:57:30.306531) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-21 05:57:30.306833) ========= /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=8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:57:30 INFO - MultiFileLogger online at 20170821 05:57:30 in /builds/slave/test 05:57:30 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 05:57:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:57:30 INFO - {'append_to_log': False, 05:57:30 INFO - 'base_work_dir': '/builds/slave/test', 05:57:30 INFO - 'blob_upload_branch': 'Firefox', 05:57:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:57:30 INFO - 'branch': 'Firefox', 05:57:30 INFO - 'buildbot_json_path': 'buildprops.json', 05:57:30 INFO - 'code_coverage': False, 05:57:30 INFO - 'config_files': ('talos/linux_config.py',), 05:57:30 INFO - 'default_actions': ('clobber', 05:57:30 INFO - 'read-buildbot-config', 05:57:30 INFO - 'download-and-extract', 05:57:30 INFO - 'populate-webroot', 05:57:30 INFO - 'create-virtualenv', 05:57:30 INFO - 'install', 05:57:30 INFO - 'setup-mitmproxy', 05:57:30 INFO - 'run-tests'), 05:57:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:57:30 INFO - 'disable_ccov_upload': False, 05:57:30 INFO - 'download_minidump_stackwalk': True, 05:57:30 INFO - 'download_symbols': 'ondemand', 05:57:30 INFO - 'enable_stylo': False, 05:57:30 INFO - 'enable_webrender': False, 05:57:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:57:30 INFO - 'tooltool.py': '/tools/tooltool.py', 05:57:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:57:30 INFO - '/tools/misc-python/virtualenv.py')}, 05:57:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:57:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:57:30 INFO - 'gecko_profile': False, 05:57:30 INFO - 'gecko_profile_interval': 0, 05:57:30 INFO - 'installer_path': 'installer.exe', 05:57:30 INFO - 'log_level': 'info', 05:57:30 INFO - 'log_name': 'talos', 05:57:30 INFO - 'log_to_console': True, 05:57:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:57:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:57:30 INFO - 'opt_config_files': (), 05:57:30 INFO - 'pip_index': False, 05:57:30 INFO - 'suite': 'dromaeojs-e10s', 05:57:30 INFO - 'system_bits': '32', 05:57:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:57:30 INFO - 'title': 'talos-linux64-ix-038', 05:57:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:57:30 INFO - 'use_talos_json': True, 05:57:30 INFO - 'verify': 'False', 05:57:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:57:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:57:30 INFO - 'work_dir': 'build'} 05:57:30 INFO - [mozharness: 2017-08-21 12:57:30.467096Z] Running clobber step. 05:57:30 INFO - Running pre-action listener: _resource_record_pre_action 05:57:30 INFO - Running main action method: clobber 05:57:30 INFO - rmtree: /builds/slave/test/build 05:57:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:57:32 INFO - Running post-action listener: _resource_record_post_action 05:57:32 INFO - [mozharness: 2017-08-21 12:57:32.153988Z] Finished clobber step (success) 05:57:32 INFO - [mozharness: 2017-08-21 12:57:32.154087Z] Running read-buildbot-config step. 05:57:32 INFO - Running pre-action listener: _resource_record_pre_action 05:57:32 INFO - Running main action method: read_buildbot_config 05:57:32 INFO - Using buildbot properties: 05:57:32 INFO - { 05:57:32 INFO - "project": "", 05:57:32 INFO - "product": "firefox", 05:57:32 INFO - "who": "archaeopteryx@coole-files.de", 05:57:32 INFO - "installer_path": "public/build/target.tar.bz2", 05:57:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:57:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:57:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:57:32 INFO - "stage_platform": "linux64-pgo", 05:57:32 INFO - "basedir": "/builds/slave/test", 05:57:32 INFO - "buildnumber": 121, 05:57:32 INFO - "platform": "ubuntu64_hw", 05:57:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:57:32 INFO - "slavebuilddir": "test", 05:57:32 INFO - "taskId": "KlIvFpicQ2-xj0OM4l-A8A", 05:57:32 INFO - "branch": "mozilla-central", 05:57:32 INFO - "script_repo_revision": "production", 05:57:32 INFO - "revision": "c7c96eebbcb91e5e0c8ef0dbbb5324812fa1e476", 05:57:32 INFO - "slavename": "talos-linux64-ix-038", 05:57:32 INFO - "repo_path": "mozilla-central" 05:57:32 INFO - } 05:57:32 INFO - Finding installer, test and symbols from parent task. 05:57:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KlIvFpicQ2-xj0OM4l-A8A'}, attempt #1 05:57:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KlIvFpicQ2-xj0OM4l-A8A'}, attempt #1 05:57:33 INFO - Task dependencies: VoBTrwLDQM-CaEcOvQaXfQ 05:57:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ'}, attempt #1 05:57:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.tar.bz2 05:57:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.test_packages.json 05:57:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.crashreporter-symbols.zip 05:57:33 INFO - Running post-action listener: _resource_record_post_action 05:57:33 INFO - [mozharness: 2017-08-21 12:57:33.532750Z] Finished read-buildbot-config step (success) 05:57:33 INFO - [mozharness: 2017-08-21 12:57:33.532967Z] Running download-and-extract step. 05:57:33 INFO - Running pre-action listener: _resource_record_pre_action 05:57:33 INFO - Running main action method: download_and_extract 05:57:33 INFO - mkdir: /builds/slave/test/build/tests 05:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:33 INFO - trying https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.test_packages.json 05:57:33 INFO - Downloading https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:57:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:57:34 INFO - Downloaded 989 bytes. 05:57:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:57:34 INFO - Using the following test package requirements: 05:57:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:57:34 INFO - u'common': [u'target.common.tests.zip'], 05:57:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:57:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:57:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:57:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:57:34 INFO - u'mozbase': [u'target.common.tests.zip'], 05:57:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:57:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:57:34 INFO - u'web-platform': [u'target.common.tests.zip', 05:57:34 INFO - u'target.web-platform.tests.tar.gz'], 05:57:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:57:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:57:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.common.tests.zip 05:57:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:57:34 INFO - Fetch https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.common.tests.zip into memory 05:57:35 INFO - Content-Length response header: 54620533 05:57:35 INFO - Bytes received: 54620533 05:57:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:57:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.common.tests.zip 05:57:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:57:46 INFO - Fetch https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.common.tests.zip into memory 05:57:47 INFO - Content-Length response header: 54620533 05:57:47 INFO - Bytes received: 54620533 05:57:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.talos.tests.zip 05:57:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:57:59 INFO - Fetch https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.talos.tests.zip into memory 05:57:59 INFO - Content-Length response header: 14496256 05:57:59 INFO - Bytes received: 14496256 05:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:00 INFO - trying https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.tar.bz2 05:58:00 INFO - Downloading https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:58:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:58:01 INFO - Downloaded 63117551 bytes. 05:58:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.tar.bz2 05:58:01 INFO - mkdir: /builds/slave/test/properties 05:58:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:01 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:01 INFO - Contents: 05:58:01 INFO - build_url:https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.tar.bz2 05:58:01 INFO - Running post-action listener: _resource_record_post_action 05:58:01 INFO - Running post-action listener: find_tests_for_verification 05:58:01 INFO - Running post-action listener: set_extra_try_arguments 05:58:01 INFO - [mozharness: 2017-08-21 12:58:01.323201Z] Finished download-and-extract step (success) 05:58:01 INFO - [mozharness: 2017-08-21 12:58:01.323298Z] Running populate-webroot step. 05:58:01 INFO - Running pre-action listener: _resource_record_pre_action 05:58:01 INFO - Running main action method: populate_webroot 05:58:01 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:01 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 05:58:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:01 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 05:58:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:58:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:01 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:58:01 INFO - 'talos_options': ['--stylo'], 05:58:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:58:01 INFO - 'tests': ['damp', 'tps']}, 05:58:01 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:58:01 INFO - 'talos_options': ['--stylo'], 05:58:01 INFO - 'tests': ['damp', 'tps']}, 05:58:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:58:01 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 05:58:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:58:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:58:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:58:01 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:58:01 INFO - 'talos_options': ['--stylo'], 05:58:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:58:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:01 INFO - 'ts_paint', 05:58:01 INFO - 'tpaint', 05:58:01 INFO - 'sessionrestore', 05:58:01 INFO - 'sessionrestore_many_windows', 05:58:01 INFO - 'sessionrestore_no_auto_restore', 05:58:01 INFO - 'tabpaint']}, 05:58:01 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 05:58:01 INFO - 'tests': ['a11yr', 05:58:01 INFO - 'ts_paint', 05:58:01 INFO - 'tpaint', 05:58:01 INFO - 'sessionrestore', 05:58:01 INFO - 'sessionrestore_many_windows', 05:58:01 INFO - 'sessionrestore_no_auto_restore', 05:58:01 INFO - 'tabpaint']}, 05:58:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:58:01 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:58:01 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 05:58:01 INFO - 'tests': ['bloom_basic_singleton']}, 05:58:01 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 05:58:01 INFO - 'tests': ['bloom_basic']}, 05:58:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:01 INFO - 'tsvgr_opacity', 05:58:01 INFO - 'tart', 05:58:01 INFO - 'tscrollx', 05:58:01 INFO - 'tsvg_static']}, 05:58:01 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 05:58:01 INFO - 'tests': ['tsvgx', 05:58:01 INFO - 'tsvgr_opacity', 05:58:01 INFO - 'tart', 05:58:01 INFO - 'tscrollx', 05:58:01 INFO - 'tsvg_static']}, 05:58:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:58:01 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:58:01 INFO - 'talos_options': ['--stylo'], 05:58:01 INFO - 'tests': ['tp5o']}, 05:58:01 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:58:01 INFO - 'talos_options': ['--mitmproxy', 05:58:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:58:01 INFO - '--firstNonBlankPaint'], 05:58:01 INFO - 'tests': ['tp6_google', 05:58:01 INFO - 'tp6_youtube', 05:58:01 INFO - 'tp6_amazon', 05:58:01 INFO - 'tp6_facebook']}, 05:58:01 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:58:01 INFO - 'talos_options': ['--stylo', 05:58:01 INFO - '--mitmproxy', 05:58:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:58:01 INFO - '--firstNonBlankPaint'], 05:58:01 INFO - 'tests': ['tp6_google', 05:58:01 INFO - 'tp6_youtube', 05:58:01 INFO - 'tp6_amazon', 05:58:01 INFO - 'tp6_facebook']}, 05:58:01 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:58:01 INFO - 'talos_options': ['--stylo', 05:58:01 INFO - '--stylo-threads=1', 05:58:01 INFO - '--mitmproxy', 05:58:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:58:01 INFO - '--firstNonBlankPaint'], 05:58:01 INFO - 'tests': ['tp6_google', 05:58:01 INFO - 'tp6_youtube', 05:58:01 INFO - 'tp6_amazon', 05:58:01 INFO - 'tp6_facebook']}, 05:58:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:58:01 INFO - 'talos_options': ['--xperf_path', 05:58:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:01 INFO - 'tests': ['tp5n']}, 05:58:01 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:58:01 INFO - 'talos_options': ['--stylo', 05:58:01 INFO - '--xperf_path', 05:58:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:01 INFO - 'tests': ['tp5n']}}} 05:58:01 INFO - Running post-action listener: _resource_record_post_action 05:58:01 INFO - [mozharness: 2017-08-21 12:58:01.337687Z] Finished populate-webroot step (success) 05:58:01 INFO - [mozharness: 2017-08-21 12:58:01.337776Z] Running create-virtualenv step. 05:58:01 INFO - Running pre-action listener: _resource_record_pre_action 05:58:01 INFO - Running main action method: create_virtualenv 05:58:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:58:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:01 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:58:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:01 INFO - Using real prefix '/usr' 05:58:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:03 INFO - Installing pip.................done. 05:58:03 INFO - Return code: 0 05:58:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:58:04 INFO - Reading from file tmpfile_stdout 05:58:04 INFO - Output received: 05:58:04 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:58:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58: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')]} 05:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b130>, '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 0x1e1c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58: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', 'pip>=1.5'] in /builds/slave/test/build 05:58: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 pip>=1.5 05:58:04 INFO - Using env: {'DISPLAY': ':0', 05:58:04 INFO - 'HOME': '/home/cltbld', 05:58:04 INFO - 'LANG': 'en_US.UTF-8', 05:58:04 INFO - 'LANGUAGE': 'en_US:en', 05:58:04 INFO - 'LOGNAME': 'cltbld', 05:58:04 INFO - 'MAIL': '/var/mail/cltbld', 05:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:04 INFO - 'MOZ_NO_REMOTE': '1', 05:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:04 INFO - 'NO_EM_RESTART': '1', 05:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:04 INFO - 'PWD': '/builds/slave/test', 05:58:04 INFO - 'SHELL': '/bin/bash', 05:58:04 INFO - 'SHLVL': '1', 05:58:04 INFO - 'TERM': 'linux', 05:58:04 INFO - 'TMOUT': '86400', 05:58:04 INFO - 'USER': 'cltbld', 05:58:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 05:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:04 INFO - '_': '/tools/buildbot/bin/python'} 05:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:58:04 INFO - Cleaning up... 05:58:04 INFO - Return code: 0 05:58:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58: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')]} 05:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58: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', '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 0x1aaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b130>, '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 0x1e1c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:58: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 psutil>=3.1.1 05:58:04 INFO - Using env: {'DISPLAY': ':0', 05:58:04 INFO - 'HOME': '/home/cltbld', 05:58:04 INFO - 'LANG': 'en_US.UTF-8', 05:58:04 INFO - 'LANGUAGE': 'en_US:en', 05:58:04 INFO - 'LOGNAME': 'cltbld', 05:58:04 INFO - 'MAIL': '/var/mail/cltbld', 05:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:04 INFO - 'MOZ_NO_REMOTE': '1', 05:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:04 INFO - 'NO_EM_RESTART': '1', 05:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:04 INFO - 'PWD': '/builds/slave/test', 05:58:04 INFO - 'SHELL': '/bin/bash', 05:58:04 INFO - 'SHLVL': '1', 05:58:04 INFO - 'TERM': 'linux', 05:58:04 INFO - 'TMOUT': '86400', 05:58:04 INFO - 'USER': 'cltbld', 05:58:04 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 05:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:04 INFO - '_': '/tools/buildbot/bin/python'} 05:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:04 INFO - Downloading/unpacking psutil>=3.1.1 05:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:05 INFO - Installing collected packages: psutil 05:58:05 INFO - Running setup.py install for psutil 05:58:05 INFO - building 'psutil._psutil_linux' extension 05:58:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:58:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:58:06 INFO - building 'psutil._psutil_posix' extension 05:58:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:58:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:58:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:06 INFO - Successfully installed psutil 05:58:06 INFO - Cleaning up... 05:58:06 INFO - Return code: 0 05:58:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:06 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 0x1aaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b130>, '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 0x1e1c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:58:06 INFO - Using env: {'DISPLAY': ':0', 05:58:06 INFO - 'HOME': '/home/cltbld', 05:58:06 INFO - 'LANG': 'en_US.UTF-8', 05:58:06 INFO - 'LANGUAGE': 'en_US:en', 05:58:06 INFO - 'LOGNAME': 'cltbld', 05:58:06 INFO - 'MAIL': '/var/mail/cltbld', 05:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:06 INFO - 'MOZ_NO_REMOTE': '1', 05:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:06 INFO - 'NO_EM_RESTART': '1', 05:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:06 INFO - 'PWD': '/builds/slave/test', 05:58:06 INFO - 'SHELL': '/bin/bash', 05:58:06 INFO - 'SHLVL': '1', 05:58:06 INFO - 'TERM': 'linux', 05:58:06 INFO - 'TMOUT': '86400', 05:58:06 INFO - 'USER': 'cltbld', 05:58:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 05:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:06 INFO - '_': '/tools/buildbot/bin/python'} 05:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:58: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 05:58: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 05:58: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 05:58: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 05:58:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:58:07 INFO - Installing collected packages: mozsystemmonitor 05:58:07 INFO - Running setup.py install for mozsystemmonitor 05:58:07 INFO - Successfully installed mozsystemmonitor 05:58:07 INFO - Cleaning up... 05:58:07 INFO - Return code: 0 05:58:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58: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')]} 05:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:07 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 0x1aaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b130>, '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 0x1e1c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:58:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:58:07 INFO - Using env: {'DISPLAY': ':0', 05:58:07 INFO - 'HOME': '/home/cltbld', 05:58:07 INFO - 'LANG': 'en_US.UTF-8', 05:58:07 INFO - 'LANGUAGE': 'en_US:en', 05:58:07 INFO - 'LOGNAME': 'cltbld', 05:58:07 INFO - 'MAIL': '/var/mail/cltbld', 05:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:07 INFO - 'MOZ_NO_REMOTE': '1', 05:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:07 INFO - 'NO_EM_RESTART': '1', 05:58:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:07 INFO - 'PWD': '/builds/slave/test', 05:58:07 INFO - 'SHELL': '/bin/bash', 05:58:07 INFO - 'SHLVL': '1', 05:58:07 INFO - 'TERM': 'linux', 05:58:07 INFO - 'TMOUT': '86400', 05:58:07 INFO - 'USER': 'cltbld', 05:58:07 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 05:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:07 INFO - '_': '/tools/buildbot/bin/python'} 05:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:08 INFO - Downloading/unpacking jsonschema==2.5.1 05:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:09 INFO - warning: no files found matching '*.txt' 05:58:09 INFO - no previously-included directories found matching 'build' 05:58:09 INFO - no previously-included directories found matching 'dist' 05:58:09 INFO - no previously-included directories found matching '.git*' 05:58:09 INFO - Installing collected packages: jsonschema, functools32 05:58:09 INFO - Running setup.py install for functools32 05:58:09 INFO - warning: no files found matching '*.txt' 05:58:09 INFO - no previously-included directories found matching 'build' 05:58:09 INFO - no previously-included directories found matching 'dist' 05:58:09 INFO - no previously-included directories found matching '.git*' 05:58:09 INFO - Successfully installed jsonschema functools32 05:58:09 INFO - Cleaning up... 05:58:09 INFO - Return code: 0 05:58:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:09 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 0x1aaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b130>, '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 0x1e1c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:58:09 INFO - Using env: {'DISPLAY': ':0', 05:58:09 INFO - 'HOME': '/home/cltbld', 05:58:09 INFO - 'LANG': 'en_US.UTF-8', 05:58:09 INFO - 'LANGUAGE': 'en_US:en', 05:58:09 INFO - 'LOGNAME': 'cltbld', 05:58:09 INFO - 'MAIL': '/var/mail/cltbld', 05:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:09 INFO - 'MOZ_NO_REMOTE': '1', 05:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:09 INFO - 'NO_EM_RESTART': '1', 05:58:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:09 INFO - 'PWD': '/builds/slave/test', 05:58:09 INFO - 'SHELL': '/bin/bash', 05:58:09 INFO - 'SHLVL': '1', 05:58:09 INFO - 'TERM': 'linux', 05:58:09 INFO - 'TMOUT': '86400', 05:58:09 INFO - 'USER': 'cltbld', 05:58:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 05:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:09 INFO - '_': '/tools/buildbot/bin/python'} 05:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:58:09 INFO - Cleaning up... 05:58:09 INFO - Return code: 0 05:58:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:09 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 0x1aaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b130>, '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 0x1e1c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:58:09 INFO - Using env: {'DISPLAY': ':0', 05:58:09 INFO - 'HOME': '/home/cltbld', 05:58:09 INFO - 'LANG': 'en_US.UTF-8', 05:58:09 INFO - 'LANGUAGE': 'en_US:en', 05:58:09 INFO - 'LOGNAME': 'cltbld', 05:58:09 INFO - 'MAIL': '/var/mail/cltbld', 05:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:09 INFO - 'MOZ_NO_REMOTE': '1', 05:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:09 INFO - 'NO_EM_RESTART': '1', 05:58:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:09 INFO - 'PWD': '/builds/slave/test', 05:58:09 INFO - 'SHELL': '/bin/bash', 05:58:09 INFO - 'SHLVL': '1', 05:58:09 INFO - 'TERM': 'linux', 05:58:09 INFO - 'TMOUT': '86400', 05:58:09 INFO - 'USER': 'cltbld', 05:58:09 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 05:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:09 INFO - '_': '/tools/buildbot/bin/python'} 05:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:11 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:11 INFO - Downloading docopt-0.6.1.tar.gz 05:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:11 INFO - Running setup.py install for blobuploader 05:58:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:11 INFO - Running setup.py install for requests 05:58:12 INFO - Running setup.py install for docopt 05:58:12 INFO - Successfully installed blobuploader requests docopt 05:58:12 INFO - Cleaning up... 05:58:12 INFO - Return code: 0 05:58:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:12 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 0x1aaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b130>, '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 0x1e1c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:58:12 INFO - Using env: {'DISPLAY': ':0', 05:58:12 INFO - 'HOME': '/home/cltbld', 05:58:12 INFO - 'LANG': 'en_US.UTF-8', 05:58:12 INFO - 'LANGUAGE': 'en_US:en', 05:58:12 INFO - 'LOGNAME': 'cltbld', 05:58:12 INFO - 'MAIL': '/var/mail/cltbld', 05:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:12 INFO - 'MOZ_NO_REMOTE': '1', 05:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:12 INFO - 'NO_EM_RESTART': '1', 05:58:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:12 INFO - 'PWD': '/builds/slave/test', 05:58:12 INFO - 'SHELL': '/bin/bash', 05:58:12 INFO - 'SHLVL': '1', 05:58:12 INFO - 'TERM': 'linux', 05:58:12 INFO - 'TMOUT': '86400', 05:58:12 INFO - 'USER': 'cltbld', 05:58:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 05:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:12 INFO - '_': '/tools/buildbot/bin/python'} 05:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:12 INFO - Running setup.py (path:/tmp/pip-t6ZiRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:12 INFO - Running setup.py (path:/tmp/pip-oDHt2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:12 INFO - Running setup.py (path:/tmp/pip-4J1zDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:12 INFO - Running setup.py (path:/tmp/pip-F7kFKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:12 INFO - Running setup.py (path:/tmp/pip-GpIJjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:13 INFO - Running setup.py (path:/tmp/pip-Jv1z2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:13 INFO - Running setup.py (path:/tmp/pip-Rq3Rjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:13 INFO - Running setup.py (path:/tmp/pip-UyAsQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:13 INFO - Running setup.py (path:/tmp/pip-B76inu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:13 INFO - Running setup.py (path:/tmp/pip-mPCdR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:13 INFO - Running setup.py (path:/tmp/pip-QokeRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:13 INFO - Running setup.py (path:/tmp/pip-qbAOwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:13 INFO - Running setup.py (path:/tmp/pip-uiABxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:13 INFO - Running setup.py (path:/tmp/pip-aeARRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:13 INFO - Running setup.py (path:/tmp/pip-IjEIKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:13 INFO - Running setup.py (path:/tmp/pip-iPpkQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:13 INFO - Running setup.py (path:/tmp/pip-NZKf0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:13 INFO - Running setup.py install for manifestparser 05:58:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:14 INFO - Running setup.py install for mozcrash 05:58:14 INFO - Running setup.py install for mozdebug 05:58:14 INFO - Running setup.py install for mozdevice 05:58:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:14 INFO - Running setup.py install for mozfile 05:58:14 INFO - Running setup.py install for mozhttpd 05:58:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:14 INFO - Running setup.py install for mozinfo 05:58:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:14 INFO - Running setup.py install for mozInstall 05:58:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:14 INFO - Running setup.py install for mozleak 05:58:14 INFO - Running setup.py install for mozlog 05:58:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:14 INFO - Running setup.py install for moznetwork 05:58:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:15 INFO - Running setup.py install for mozprocess 05:58:15 INFO - Running setup.py install for mozprofile 05:58:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:15 INFO - Running setup.py install for mozrunner 05:58:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:15 INFO - Running setup.py install for mozscreenshot 05:58:15 INFO - Running setup.py install for moztest 05:58:15 INFO - Running setup.py install for mozversion 05:58:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:15 INFO - Cleaning up... 05:58:15 INFO - Return code: 0 05:58:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58: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')]} 05:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:15 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 0x1aaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b130>, '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 0x1e1c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:58:15 INFO - Using env: {'DISPLAY': ':0', 05:58:15 INFO - 'HOME': '/home/cltbld', 05:58:15 INFO - 'LANG': 'en_US.UTF-8', 05:58:15 INFO - 'LANGUAGE': 'en_US:en', 05:58:15 INFO - 'LOGNAME': 'cltbld', 05:58:15 INFO - 'MAIL': '/var/mail/cltbld', 05:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:15 INFO - 'MOZ_NO_REMOTE': '1', 05:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:15 INFO - 'NO_EM_RESTART': '1', 05:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:15 INFO - 'PWD': '/builds/slave/test', 05:58:15 INFO - 'SHELL': '/bin/bash', 05:58:15 INFO - 'SHLVL': '1', 05:58:15 INFO - 'TERM': 'linux', 05:58:15 INFO - 'TMOUT': '86400', 05:58:15 INFO - 'USER': 'cltbld', 05:58:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 05:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:15 INFO - '_': '/tools/buildbot/bin/python'} 05:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:15 INFO - Running setup.py (path:/tmp/pip-CBTrSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:58:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:15 INFO - Running setup.py (path:/tmp/pip-lI6R8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:16 INFO - Running setup.py (path:/tmp/pip-v9oJYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:16 INFO - Running setup.py (path:/tmp/pip-cyxEGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:16 INFO - Running setup.py (path:/tmp/pip-f64k93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:16 INFO - Running setup.py (path:/tmp/pip-6I10Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:16 INFO - Running setup.py (path:/tmp/pip-P_xMim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:16 INFO - Running setup.py (path:/tmp/pip-Xzvm8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:16 INFO - Running setup.py (path:/tmp/pip-jy_YF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:16 INFO - Running setup.py (path:/tmp/pip-l4Kmgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:16 INFO - Running setup.py (path:/tmp/pip-YUw9ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:16 INFO - Running setup.py (path:/tmp/pip-symSa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:16 INFO - Running setup.py (path:/tmp/pip-NPbrW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:16 INFO - Running setup.py (path:/tmp/pip-rghBal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:16 INFO - Running setup.py (path:/tmp/pip-ruX6S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:17 INFO - Running setup.py (path:/tmp/pip-1KzQZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:17 INFO - Running setup.py (path:/tmp/pip-E7AekU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:58:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:18 INFO - Downloading blessings-1.6.tar.gz 05:58:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:18 INFO - Installing collected packages: blessings 05:58:18 INFO - Running setup.py install for blessings 05:58:18 INFO - Successfully installed blessings 05:58:18 INFO - Cleaning up... 05:58:18 INFO - Return code: 0 05:58:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:18 INFO - Reading from file tmpfile_stdout 05:58:18 INFO - Current package versions: 05:58:18 INFO - argparse == 1.2.1 05:58:18 INFO - blessings == 1.6 05:58:18 INFO - blobuploader == 1.2.4 05:58:18 INFO - docopt == 0.6.1 05:58:18 INFO - functools32 == 3.2.3-2 05:58:18 INFO - jsonschema == 2.5.1 05:58:18 INFO - manifestparser == 1.1 05:58:18 INFO - mozInstall == 1.13 05:58:18 INFO - mozcrash == 1.0 05:58:18 INFO - mozdebug == 0.1 05:58:18 INFO - mozdevice == 0.51 05:58:18 INFO - mozfile == 1.2 05:58:18 INFO - mozhttpd == 0.7 05:58:18 INFO - mozinfo == 0.10 05:58:18 INFO - mozleak == 0.1 05:58:18 INFO - mozlog == 3.5 05:58:18 INFO - moznetwork == 0.27 05:58:18 INFO - mozprocess == 0.25 05:58:18 INFO - mozprofile == 0.28 05:58:18 INFO - mozrunner == 6.13 05:58:18 INFO - mozscreenshot == 0.1 05:58:18 INFO - mozsystemmonitor == 0.3 05:58:18 INFO - moztest == 0.8 05:58:18 INFO - mozversion == 1.4 05:58:18 INFO - psutil == 3.1.1 05:58:18 INFO - requests == 1.2.3 05:58:18 INFO - wsgiref == 0.1.2 05:58:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:18 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 0x1aaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b130>, '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 0x1e1c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:58:18 INFO - Using env: {'DISPLAY': ':0', 05:58:18 INFO - 'HOME': '/home/cltbld', 05:58:18 INFO - 'LANG': 'en_US.UTF-8', 05:58:18 INFO - 'LANGUAGE': 'en_US:en', 05:58:18 INFO - 'LOGNAME': 'cltbld', 05:58:18 INFO - 'MAIL': '/var/mail/cltbld', 05:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:18 INFO - 'MOZ_NO_REMOTE': '1', 05:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:18 INFO - 'NO_EM_RESTART': '1', 05:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:18 INFO - 'PWD': '/builds/slave/test', 05:58:18 INFO - 'SHELL': '/bin/bash', 05:58:18 INFO - 'SHLVL': '1', 05:58:18 INFO - 'TERM': 'linux', 05:58:18 INFO - 'TMOUT': '86400', 05:58:18 INFO - 'USER': 'cltbld', 05:58:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 05:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:18 INFO - '_': '/tools/buildbot/bin/python'} 05:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:58:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:58:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:58:20 INFO - Installing collected packages: simplejson 05:58:20 INFO - Running setup.py install for simplejson 05:58:20 INFO - building 'simplejson._speedups' extension 05:58:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 05:58:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 05:58:21 INFO - Successfully installed simplejson 05:58:21 INFO - Cleaning up... 05:58:21 INFO - Return code: 0 05:58:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aaf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c7aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1b130>, '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 0x1e1c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c4c0>, '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': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:58:21 INFO - Using env: {'DISPLAY': ':0', 05:58:21 INFO - 'HOME': '/home/cltbld', 05:58:21 INFO - 'LANG': 'en_US.UTF-8', 05:58:21 INFO - 'LANGUAGE': 'en_US:en', 05:58:21 INFO - 'LOGNAME': 'cltbld', 05:58:21 INFO - 'MAIL': '/var/mail/cltbld', 05:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:21 INFO - 'MOZ_NO_REMOTE': '1', 05:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:21 INFO - 'NO_EM_RESTART': '1', 05:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:21 INFO - 'PWD': '/builds/slave/test', 05:58:21 INFO - 'SHELL': '/bin/bash', 05:58:21 INFO - 'SHLVL': '1', 05:58:21 INFO - 'TERM': 'linux', 05:58:21 INFO - 'TMOUT': '86400', 05:58:21 INFO - 'USER': 'cltbld', 05:58:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 05:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:21 INFO - '_': '/tools/buildbot/bin/python'} 05:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:58:21 INFO - Cleaning up... 05:58:21 INFO - Return code: 0 05:58:21 INFO - Running post-action listener: _resource_record_post_action 05:58:21 INFO - Running post-action listener: _start_resource_monitoring 05:58:21 INFO - Starting resource monitoring. 05:58:21 INFO - [mozharness: 2017-08-21 12:58:21.399107Z] Finished create-virtualenv step (success) 05:58:21 INFO - [mozharness: 2017-08-21 12:58:21.399627Z] Running install step. 05:58:21 INFO - Running pre-action listener: _resource_record_pre_action 05:58:21 INFO - Running main action method: install 05:58:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:21 INFO - Reading from file tmpfile_stdout 05:58:21 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:58:21 INFO - Reading from file tmpfile_stdout 05:58:21 INFO - Output received: 05:58:21 INFO - Usage: mozinstall [options] installer 05:58:21 INFO - Options: 05:58:21 INFO - -h, --help show this help message and exit 05:58:21 INFO - -d DEST, --destination=DEST 05:58:21 INFO - Directory to install application into. [default: 05:58:21 INFO - "/builds/slave/test"] 05:58:21 INFO - --app=APP Application being installed. [default: firefox] 05:58:21 INFO - mkdir: /builds/slave/test/build/application 05:58:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:58:41 INFO - Reading from file tmpfile_stdout 05:58:41 INFO - Output received: 05:58:41 INFO - /builds/slave/test/build/application/firefox/firefox 05:58:41 INFO - Running post-action listener: _resource_record_post_action 05:58:41 INFO - [mozharness: 2017-08-21 12:58:41.118537Z] Finished install step (success) 05:58:41 INFO - [mozharness: 2017-08-21 12:58:41.118882Z] Running setup-mitmproxy step. 05:58:41 INFO - Running pre-action listener: _resource_record_pre_action 05:58:41 INFO - Running main action method: setup_mitmproxy 05:58:41 INFO - Skipping: mitmproxy is not required 05:58:41 INFO - Running post-action listener: _resource_record_post_action 05:58:41 INFO - [mozharness: 2017-08-21 12:58:41.120505Z] Finished setup-mitmproxy step (success) 05:58:41 INFO - [mozharness: 2017-08-21 12:58:41.120815Z] Running run-tests step. 05:58:41 INFO - Running pre-action listener: _resource_record_pre_action 05:58:41 INFO - Running pre-action listener: _set_gcov_prefix 05:58:41 INFO - Running main action method: run_tests 05:58:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:58:41 INFO - Python 2.7.3 05:58:41 INFO - Return code: 0 05:58:41 INFO - grabbing minidump binary from tooltool 05:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x1e1b130>, '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 0x1e1c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:58:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:58:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:58:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:58:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:58:41 INFO - Return code: 0 05:58:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:58:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:58:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:58:41 INFO - ENV: RUST_BACKTRACE is now full 05:58:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:58:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:58:41 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/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 05:58:41 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/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 05:58:41 INFO - Using env: {'DISPLAY': ':0', 05:58:41 INFO - 'HOME': '/home/cltbld', 05:58:41 INFO - 'LANG': 'en_US.UTF-8', 05:58:41 INFO - 'LANGUAGE': 'en_US:en', 05:58:41 INFO - 'LOGNAME': 'cltbld', 05:58:41 INFO - 'MAIL': '/var/mail/cltbld', 05:58:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:58:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:41 INFO - 'MOZ_NO_REMOTE': '1', 05:58:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:41 INFO - 'NO_EM_RESTART': '1', 05:58:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:41 INFO - 'PWD': '/builds/slave/test', 05:58:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:58:41 INFO - 'RUST_BACKTRACE': 'full', 05:58:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:58:41 INFO - 'SHELL': '/bin/bash', 05:58:41 INFO - 'SHLVL': '1', 05:58:41 INFO - 'TERM': 'linux', 05:58:41 INFO - 'TMOUT': '86400', 05:58:41 INFO - 'USER': 'cltbld', 05:58:41 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667', 05:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:41 INFO - '_': '/tools/buildbot/bin/python'} 05:58:41 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/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 05:58:41 INFO - mozversion application_buildid: 20170821114200 05:58:41 INFO - mozversion application_changeset: c7c96eebbcb91e5e0c8ef0dbbb5324812fa1e476 05:58:41 INFO - mozversion application_display_name: Nightly 05:58:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:58:41 INFO - mozversion application_name: Firefox 05:58:41 INFO - mozversion application_remotingname: firefox 05:58:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:58:41 INFO - mozversion application_vendor: Mozilla 05:58:41 INFO - mozversion application_version: 57.0a1 05:58:41 INFO - mozversion platform_buildid: 20170821114200 05:58:41 INFO - mozversion platform_changeset: c7c96eebbcb91e5e0c8ef0dbbb5324812fa1e476 05:58:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:58:41 INFO - mozversion platform_version: 57.0a1 05:58:41 INFO - using testdate: 1503320321 05:58:41 INFO - actual date: 1503320321 05:58:41 INFO - starting webserver on 'localhost:48147' 05:58:41 INFO - SUITE-START | Running 2 tests 05:58:41 INFO - TEST-START | dromaeo_css 05:58:41 INFO - Initialising browser for dromaeo_css test... 05:58:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48147/getInfo.html -profile /tmp/tmpDKYR2W/profile 05:58:41 INFO - TEST-INFO | started process 5375 (/builds/slave/test/build/application/firefox/firefox http://localhost:48147/getInfo.html) 05:58:47 INFO - TEST-INFO | 5375: exit 0 05:58:48 INFO - Browser initialized. 05:58:48 INFO - Running cycle 1/1 for dromaeo_css test... 05:58:48 INFO - TEST-INFO | started process 5554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDKYR2W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:48 INFO - PID 5554 | 05:58:48 INFO - PID 5554 | (/builds/slave/test/build/application/firefox/firefox:5603): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:58:48 INFO - PID 5554 | 05:58:49 INFO - PID 5554 | 05:58:49 INFO - PID 5554 | (/builds/slave/test/build/application/firefox/firefox:5660): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:58:49 INFO - PID 5554 | 05:58:49 INFO - PID 5554 | __metrics Screen width/height:1600/1200 05:58:49 INFO - PID 5554 | colorDepth:24 05:58:49 INFO - PID 5554 | Browser inner width/height: 1024/768 05:58:49 INFO - PID 5554 | __metrics 05:58:59 INFO - PID 5554 | RSS: Main: 165797888 05:58:59 INFO - PID 5554 | 06:01:57 INFO - PID 5554 | Cycle 1(1): loaded http://localhost:48147/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48147/tests/dromaeo/cssquery-ext.html) 06:01:58 INFO - PID 5554 | RSS: Main: 168620032 06:01:58 INFO - PID 5554 | 06:04:59 INFO - PID 5554 | Cycle 1(1): loaded http://localhost:48147/tests/dromaeo/cssquery-ext.html (next: http://localhost:48147/tests/dromaeo/cssquery-jquery.html) 06:05:00 INFO - PID 5554 | RSS: Main: 166932480 06:05:00 INFO - PID 5554 | 06:08:01 INFO - PID 5554 | Cycle 1(1): loaded http://localhost:48147/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48147/tests/dromaeo/cssquery-mootools.html) 06:08:02 INFO - PID 5554 | RSS: Main: 169439232 06:08:02 INFO - PID 5554 | 06:11:03 INFO - PID 5554 | Cycle 1(1): loaded http://localhost:48147/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48147/tests/dromaeo/cssquery-prototype.html) 06:11:04 INFO - PID 5554 | RSS: Main: 167567360 06:11:04 INFO - PID 5554 | 06:14:07 INFO - PID 5554 | Cycle 1(1): loaded http://localhost:48147/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48147/tests/dromaeo/cssquery-yui.html) 06:14:08 INFO - PID 5554 | RSS: Main: 170749952 06:14:08 INFO - PID 5554 | 06:17:10 INFO - PID 5554 | Cycle 1(1): loaded http://localhost:48147/tests/dromaeo/cssquery-yui.html (next: http://localhost:48147/tests/dromaeo/cssquery-dojo.html) 06:17:10 INFO - PID 5554 | RSS: Main: 171712512 06:17:10 INFO - PID 5554 | 06:17:10 INFO - PID 5554 | __start_tp_report 06:17:10 INFO - PID 5554 | _x_x_mozilla_page_load 06:17:10 INFO - PID 5554 | _x_x_mozilla_page_load_details 06:17:10 INFO - PID 5554 | |i|pagename|runs| 06:17:10 INFO - PID 5554 | |0;dojo.html;3486.9651303486958;3511.034465521982;3537.3809583322914;3538.23927855511;3544.4151714967034;6122.908156377658;6177.598456100356;6213.813585592434;6216.347283535231;6249.218847644044;6187.721552530147;6220.440160385564;6245.531585131111;6246.781362652308;6281.528885333595;5518.227448157241;5539.944600553983;5548.500634942854;5568.3596386415475;5574.1638754187;5387.919181212285;5399.595030372718;5484.067708489546;5487.98472282627;5561.860953476155;5459.836204913859;5460.945390546103;5497.945020549783;5555.972220138873;5563.860903477425;5485.588580856412;5491.956528259658;5520.144377621435;5551.639143455663;5581.302337207849;5372.54333381663;5431.972840135813;5449.64577302478;5520.751566179491;5536.833894983157;6115.755369785204;6180;6197.194364732601;6213.471854892339;6216.906746398808;6740.460763138986;6796.286389929085;6830.248672646005;6886.793396198072;6904.067950826624;6680.098186744776;6829.556078854858;6837.726490940357;6860.03959445678;6902.275261097613;6327.430531252209;6331.081993111019;6353.809385718436;6363.61818290904;6364.77723279683;6926.861462770717;6929.5842249465195;6950.200726916368;7033;7040.331168538981;6455.903161452582;6629.966850165718;6652.933470665232;6662.56693314933;6748.29142939994;6639.269680335159;6640.933590664128;6671.232808227019;6679.632620205838;6726.562773419712;6615.470762339001;6629.668516574152;6634.336566343423;6735;6738.494612904052;6600.5049621278595;6708.3291670833505;6716.429103526255;6766.661666916634;6767.661616919135;4801.423829140525;4857.53853383928;4859.416869975626;4861.538153875376;4884.023195360942;4391.055922976575;4403;4407.030453300269;4409.5149533551285;4416.933745993812;6384.138141350858;6399.392057754506;6401.199850018747;6495.155629768195;6505.154329937078;6671.833204169838;6779.118714567173;6782.016607591971;6810.318968103249;6835.350641689031;6386.808395748135;6435.099086127946;6456.741730330734;6457.870842583122;6459.192600924885;5438.45615438453;5518.972405138029;5521.116621340566;5532.3914369419335;5536.169574563767;7040.260772618802;7107.538010029331;7189.029481019996;7197.136343638692;7218.963905180441;6610;6729.764458243938;6768.323167683291;6781.898271525833;6810.5913645181445;7053.0830991970715;7086.149662040588;7087.468439866928;7089.468289878177;7203.279672032964;6646.2356828965285;6699.363560461748;6705.1283333166375;6795.524313298021;6807.897881531682;6677.232118306457;6812.216595091628;6824.18109826824;6908.5509441886115;6917.342852429011;6538.673066346569;6639;6651.667416629246;6665.700043497957;6679.6994135265;6497.31778163305;6605.240397354173;6677.332266773284;6681.866362672817;6697.09589205451;6586.4401525868925;6593.538452308292;6606.471482281502;6691.933080669326;6693.698783554849;6610.10763546915;6670;6671.266160722414;6689.431398331197;6748.122744043243;6440.35596440371;6445.548811583331;6524.543281970216;6533.509986751108;6541.378569035934 06:17:10 INFO - PID 5554 | |1;ext.html;888.1591961071331;901.589776651624;930.1767935377192;950.5864948747295;950.6245033211877;34167.82916085419;34832.651673483255;42433;43319.35020974688;43353.34969975445;42784.3582346265;43365.78317108418;43416.34875476862;43417;43561.56438435615;7607.429442791785;7695.038120234971;7729.72945946892;7747.690092396298;7750.108737495204;7531.096268447794;7659.195784442637;7662.501937374081;7667;7669.309762121408;7704.152543220242;7729.806754831118;7740.225977402271;7744;7746.651400686983;7610.124835643889;7621.161672216052;7654.272844079831;7662.578558179298;7676.46264761467;7415.480916335859;7472.364848987842;7477.626118694098;7495.625218739041;7499.512531685423;37560;38053;38057.42913856294;38137.61862381369;38142.42786358207;3433.141714571357;3437.9656203437894;3444.603870554868;3469.1847415857255;3469.6356882527225;30780.8460957696;30958.690413095806;31132;31161.22096947572;31195.220119496968;5087.414947281073;5102.795888164469;5131.538161565477;5159.2003239497935;5160.612954028463;195024;196156.0192199044;196645;196688;196859;49517.752411237714;49550.50449495531;49581.752091239316;49604.50395495999;49655.75172124188;52713;52752;52828.73585632124;52844;52878.735606322494;16416;16781.412650557173;16784.664306714043;16837.747433788503;16876;13763.31183440824;13781.173129612054;13790.65523361924;13791.862081379259;13798.103123296954;14106.71786564263;14245.501407450689;14351.856481435261;14407.207603581694;14475.710485790225;5633.549316054706;5740.712964351766;5787.305523337142;5820.097884827858;5843.357230704619;1058.9523471443804;1066.6053560182781;1075.0485820049312;1078.2344535379812;1084.9945750271197;24280.63579046316;24353.878230608734;31681.366372672877;31888.362232755215;32697.182570435452;1152.8817047463947;1155.9075273978062;1164.9242799218023;1168.1822724093;1189;13452.394642241123;13623.659408514866;13644;13795.931020344835;13797.172169669851;280342;281412;281665;292268;297142;59827.10259346113;59853.40146598478;59930.700346497986;60102;60153;1455.5560554031122;1505.0819000409742;1514.1596413990342;1514.8560886715745;1520.3006616956102;28659.713402865706;28664;28994;29651.258718532208;30555.694443056174;52815.73592132015;52998.470015299354;52999;53050.73474632602;53073;232657;232759;232946;233526;233920;35245.64754352424;35786.8210658945;36096.81951590225;36114;36137.45793813042;44093;44602.10795784131;45091.32363014623;45101;45371.77314113409;34010.489842652874;34112.48831267483;34322.82838585791;34431.827840860635;34519.4822077674;34067.82966085154;34193.487097693054;34281;34714.30571388609;34847;37642.623573763914;38913.41629875497;39036;39245.41131883081;39308.80345598254;32984.67015329816;32997.50503742494;33040.1739956503;33288.83355583207;33674.49488257629;24086.15698450546;25163.24510264695;25182.461696781644;25420;25767.871160644077 06:17:10 INFO - PID 5554 | |2;jquery.html;556.4824713016893;558.8714595643002;568.5508448325822;584.8859472402881;599.625234228607;23272.88363558182;24056.639150412757;24110.276691699255;24140.15509457169;24159.39601509963;25423.74576254237;27567.172984810488;27724.168274951735;27729.58405623917;27853.02514411996;6190.3190649028575;6342.112104305401;6343.524235682342;6355.3009168991375;6356.141920840673;5916.911246331309;6134.8159555213415;6182.783602573911;6322.652254126021;6362;6101.511879049687;6112.694365281718;6116.633002019893;6119.938800612003;6121.479674227674;6117.174181485487;6122.785702500413;6133.355997620275;6137.969310153465;6138.324784273726;5703.62926409782;5718.714064296769;5719.056355701346;5720.170575266605;5726.31284245889;30286.242843928856;30685.69314306873;30770.23074423135;30847;31322.686773132205;2194.8353873459396;2236.0608544411384;2236.686863839064;2243.4391402149463;2243.887805609713;19769.209231630717;20593.8970305149;20605.587888242153;20612.484687882923;20622.690659640117;2444.5966415541416;2506.385935445809;2537.0612873236837;2537.251510804317;2563.2566555698827;152242;156552;157949.21025394913;158632;158788;14995.625109372353;15320.548712205993;15354.155521446204;15800.130992795277;15864.682706345808;23607.527849442915;23965.16121935759;24694.876525617256;24705.5058898821;24781.380465488146;10523.631672891412;10776.838347424795;10893.455327233607;10981.890181098246;10990.945045274882;9849.60601575929;9946.20430365569;9984.101430871257;10025.24810639205;10040.096391324816;9829.606815727291;9929.900700993043;9972.401655900669;10329;10365.9481702591;2618.947621047568;2630.213530233456;2681.002653023471;2752.2018614601543;2753.7317158404794;1021.8467229915424;1036.7667274863095;1045.6444808764904;1049.6483677967967;1052.321252791945;21497.355079347646;21639.78360216409;22100.778992210195;22378.10487580511;22585.093838066798;1115.8772535021142;1126.2060247525476;1131.1685910855515;1149.6665966869514;1167.4337946096136;11539.538418463335;12156.270623762426;12332.445039973223;12352.44414001372;12360.814587781191;622046;625352;626866;628635;632517;131706;132435;134701;135281.3235933814;139384;1298.1756584568866;1305.3147097773556;1336.8596297388633;1342.5703774792169;1344.2069179184327;23115.422114447272;23233.30300091;23317.183898564148;23619.173328933404;23928.760712392654;64281;64785.67607161934;65028;67713.66143169253;67888.32111679018;79506;81966.59016705117;83802;84029.57985210035;84440;14196.858031419553;14950.476733314283;14954.850451495346;15089.094654320776;15306.387744490541;25001.249962501155;25010;25070.247892563253;25150.11974580881;25439.10963116282;19058.332958346393;19263.22947082101;19379;19557;19560.510987225432;17868;17896;18274.45176644703;18375.356862509747;18521.166547505127;19308.32420865263;19510.31713890007;20154.798452015293;20414.489637759176;20478.692819608015;14985.700285994437;15043.548693539211;15191.620209494851;15195.316210770763;15279.694406112038;19726.30957916466;19754.308599198957;19946.501337466678;20138.697919530925;20175.293864714666 06:17:10 INFO - PID 5554 | |3;mootools.html;1472.352165047379;1477.416420513897;1482.5996980815187;1522.588900996731;1528.9006214596047;15498.22508874556;16114.033158010512;16156.676866462663;16160.83839161608;16637.41769038084;16440.42458513952;16712.08083555404;16719.749203761952;16724.331026758944;16726.74909876353;2657.6943651480037;2706.796990225736;2725.7683096936785;2743.6158937748733;2747.093459158473;2677.571588545833;2718.8232764870318;2721.1020363280168;2721.537338652434;2724.359775452777;2648.827826191301;2687.261003224119;2688.6639170103736;2692.4749673813612;2757.5174344489733;2483.192962287255;2513.861737604431;2515.3460100374036;2592.131635901975;2620.567606344951;2443.3769388805918;2447.559439300925;2457.348802567321;2467.161165203839;2490.3649569359877;15510.922445387701;15680.843191568052;15698.37206511738;15701;15740.212989350486;8270.958645206796;8547.273481754059;8548.74353769388;8555.572221388906;8574.528400937947;5046.848594542133;5289.709066001368;5305.3898801637915;5379.865503362408;5544.833654990357;1938.903054847252;1940.8253257206777;1957.1388589020785;2007.6586980213253;2407.3861165402886;28991.710082899113;29376;29409.852950735323;29420.70579294201;29432.264193395124;7065.4700897432895;7069.852095758631;7148.320909513588;7216.386607138347;7327.194008659043;18776.90611546961;18796.436106916815;18799.342023029403;18816.435506934813;18836.05819709009;8359.247667709935;8436.45163064399;8513.19124683154;8517.57412129391;8524.104968978168;7732.6520306586335;7790.143084260727;7954.244346787046;7955;7986.081600616004;4921.581665558396;5178.508041736029;5187.429382767892;5212.765425555859;5243.082460569385;1466.2375564706292;1477.1949287638263;1498.5654160293393;1508.7736839473948;1512.9319180636899;921.3780698028804;947.1806887042796;962.7208109648263;964.0696727657844;968.1431932739576;8059.919400805917;8082.878756818534;8191.385646076568;8197.672093116327;8222.17778222173;723.9058922340062;738.8448425830636;742.4023660952877;1008.2639673038723;1024.7694268789462;5388.622796404214;6212.192414986023;6253.155823963707;6266.621343304466;6294.271404912527;23627.173048943205;24189.15337963198;24210.87894560516;24243.51512969766;24260.02959881585;23716;24032.51934961291;24037.158699445434;24248;24457.143999959917;12545.93727031359;12649.557265495847;12665.430055647517;12673;12959.546415875398;9308.162265396148;9327.766805829637;9424.764380890532;9545.952270238604;9654.469004204837;19862.304819331253;21048.368548943556;21290.36128916135;21319.360419187447;21352;20932.267370641955;21205.469863252925;21326.253581124587;21350.35948921535;21751.347459576238;12194.268343899394;12461.87538124607;12495.187812792139;12503.062270329943;12521.93739031299;13636.454541818217;13701.246431446367;13767.655808604864;13859.930700346435;13923.58229253124;11006.834897476705;11173.49719262619;11200.271982321123;11304.660860174208;11427.714307142056;10472.26694131434;10619.36283822973;10701.090407315465;10834.891651083388;10881.075108615856;8744.78138046554;8767.254783343233;8870.822583548164;8880;9019.684311049083;8124.553149576594;8134.308583770446;8148.388870834592;8236.752897413087;8398.370122240978;8041.678332866853;8142.633581488965;8180.100188979089;8204.548749818818;8224.300934420402 06:17:10 INFO - PID 5554 | |4;prototype.html;505.863416877443;525.6399366433991;534.2307077807956;537.6263496869675;539.7355295905005;6131.141640170368;6172.475339596134;6182.381761823815;6239.937600623993;6287.685615719219;6095.939040609593;6113.187933550561;6128.356522565134;6135.509159267259;6163.445289923906;4875.829345972892;4915.877103072416;4925.679830811004;4929;4938.555530002299;4650.209464391045;4841.491643377448;4856.611471082305;4884.633652476061;4967.627427942919;4742.359781429497;4752.382190315254;4769.427668679746;4785.353977213066;4808.879778005543;4764.547368000034;4771.928421073687;4793.856184314476;4806.158922188621;4813.181759100961;4355.60799528044;4361.978190109061;4368.847090351855;4376.868693939187;4397.318415645548;5979.133025711291;6067.696615169268;6076.848078798022;6081.452669259744;6101.450869421729;5676.971615141898;5703.31560212773;5719.113537401709;5749.223854779593;5754.1944127822135;6517.250516190651;6531.542792004561;6566.540342176049;6600.570962887397;6628.867422651569;4900.877478063041;4912.410510738699;4923.606111511071;4932.954976918928;4946.87632809179;6519.4132528072705;6666.433353164938;6762.459003279726;6789.694463749143;6820.522563420563;4985.850424487271;5031.6729412588065;5032.169692000852;5041.571466425395;5088.618353623419;5117.667351622133;5123.154679477844;5135.897282054338;5137.434882162959;5180.1711726124395;5712.2288491054005;5725.484706376446;5728.083506638918;5733.426657334233;5755.424457554211;6503.902441463382;6542.574732642363;6566.770163044366;6626.469882409396;6628.403443690091;1785.4732853808157;1790.8388245058006;1800.3698705453248;1802.3241284518306;1803.5761596024925;1210.5218438716659;1242.4657397319058;1251.8608066659478;1255.8555766087018;1261.9871305268082;6266.624002559861;6319.304876463585;6323.810285691345;6332.271788744261;6358.632893927827;6781.423578995742;6788.151481064867;6795.558288711218;6816.625085620339;6837.589744615239;6151.507879369729;6172.783952561639;6199.783007594712;6252.280987686383;6277.403646653652;3516.1385460562324;3539.2213712983103;3546.1666508370513;3553.4136867417105;3555.7421037641284;6921.204061532888;6965.407940325028;6987.89518157228;6988.930110698828;7107.71569137239;6489.643069631121;6754.223264324665;6755.534230006111;6767.5672434555445;6845.8973115403305;6943.756968506078;6958.512904096766;6988.545744526589;6993.965030174817;7063.25835787235;6581.42045908988;6623.3376662333385;6653.733850646114;6692.6319052450635;6722.529422940347;6569.277379488157;6572.474202063919;6575.473962082926;6621.9337806621315;6669.266380698216;6946.340097690711;6977.511574189758;7019.789406317818;7027.402670772837;7051.294870513113;5044.772985215747;5067.721275329893;5083.898322033465;5086.3896332440345;5102.158143906362;6517.641529715911;6585.539012269095;6676.432503237085;6702.045792981969;6830.282820303995;6450;6460.741570337322;6466.932956062197;6553.442957348679;6557.2131344239;6426.839329016812;6429.421352078335;6431.646259455588;6590.879550476335;6622.337766223339;6445.645489497935;6485.935140648533;6509.609423434609;6513.609183449008;6542.83642908912;6560.507961902781;6620.337966203534;6626.403623673892;6676.1988561371;6686.465082793267;6386.744530218925;6399.520035997412;6430.3891130342545;6431.614103153825;6464.676766161767 06:17:10 INFO - PID 5554 | |5;yui.html;929.2658799548353;941.3194409857457;954.2584782771444;955.5461155950928;970.1414248390175;19115.71326430103;19632;19772.802271977274;19779.208831646716;22854.771452285473;22274.331770046883;22785.54428911421;22885.771142288573;22907.656385154238;23078.538429231405;1043.7442826507515;1069.7432616172102;1069.9197560183018;1070.2080460459242;1073.7691396349783;1029.3412216181612;1063.2982231727062;1064.872215334161;1064.952077156526;1065.1851333729703;1121.4280716834392;1122.6968718446014;1122.9943850280738;1123.0678536814464;1126.5155982927338;1117.6870476266658;1118.9048930840888;1120.2718233148437;1120.5517792882831;1127.9605213817517;822.0135836995629;822.7161629237903;822.7449490657856;823.074041703084;826.7189155687036;20801.687974680393;20916.790832091636;20960.685589716013;21097.78902210989;21315.78684213169;22705.886470567708;22912.31263062111;23112.42218944523;23516.176933807405;23625.173118940755;16995;17107;17224.913875430542;17586.208620612102;17881.195346209453;3820.789856557888;3827.6937844972335;3829.8276577554075;3831.3295173344554;3855.575886652466;157743;158941.2052939728;159562;159712;160024;17324;17484.737728934077;17828.197731102133;17932.731009034876;17935.192916318796;33368.66631333656;33874.49188262178;33975;34068.48897266543;34303.82848085744;8432.45189062709;8446.704365347183;8462.026866910384;8693.00030496501;8791.428557143765;4493.303537951622;4521.84173553924;4528.50186479487;4531.388262584509;4534.070515544306;5619.016672082369;5711.200431939532;5731.254936858265;5739.311282646109;5763.164341170591;1135.4152611405134;1157.9015783658483;1166.976660466803;1170.4849866058908;1173.313611537243;724.6702750248625;725.2493669052611;736.6206403702098;747.3572727454385;751.1849643137148;13485.932570337085;13573.932130339284;13680.452781888813;14301.141931483937;14521.273936303143;707.2538471912079;709.1206903439697;711.9679614417364;713.8685183983341;715.4348065028569;6183.96908015466;6241.313455519889;6393.9360606394275;6424.261209960914;6442.613443193423;135007;136039.31980340034;137328;138083.30958345145;141820;121358;122061.38969305097;122638;123858;124753;102635;104056;104155;104574.47712761388;106220.46889765657;11827.52689892429;11926.522939082686;11928.165028448273;11984.46069926838;12141.028717702386;49844.750776245884;50171.24743128929;50839.49160508347;50922.74538627283;51904;63415;63640.68179659072;63649;63987;64267;16263.186840658156;16493.917530412273;17042.744358834876;17131.828681713025;17138.228779704696;19765.901170494057;20138.798612013692;24034.75965240395;24495.265142045766;24641.63037554474;20800.58398832045;21420.464488387915;21447.249346272805;22245.22141725032;22509.324720258417;20609.89695051575;20638;20920.47698807542;20964.266250681154;21038.57922841504;19921.10355033998;20010.199592016157;20401.89799050995;21312.573748525254;22341.664875026563;15247.771283430535;15441.5367538974;15561;15874.365025398854;15887.205639717737;14837.629059273604;14924.85075149278;15482.690346193238;15572.37710491613;15837.524874253791 06:17:10 INFO - PID 5554 | __end_tp_report 06:17:10 INFO - PID 5554 | __start_cc_report 06:17:10 INFO - PID 5554 | _x_x_mozilla_cycle_collect,343 06:17:10 INFO - PID 5554 | __end_cc_report 06:17:10 INFO - PID 5554 | __startTimestamp1503321430306__endTimestamp 06:17:10 INFO - PID 5554 | 06:17:10 INFO - PID 5554 | ------- Summary: start ------- 06:17:10 INFO - PID 5554 | Number of tests: 6 06:17:10 INFO - PID 5554 | 06:17:10 INFO - PID 5554 | [#0] dojo.html Cycles:165 Average:6223.08 Median:6541.38 stddev:809.74 (12.4%) stddev-sans-first:783.26 06:17:10 INFO - PID 5554 | Values: 3487.0 3511.0 3537.4 3538.2 3544.4 6122.9 6177.6 6213.8 6216.3 6249.2 6187.7 6220.4 6245.5 6246.8 6281.5 5518.2 5539.9 5548.5 5568.4 5574.2 5387.9 5399.6 5484.1 5488.0 5561.9 5459.8 5460.9 5497.9 5556.0 5563.9 5485.6 5492.0 5520.1 5551.6 5581.3 5372.5 5432.0 5449.6 5520.8 5536.8 6115.8 6180.0 6197.2 6213.5 6216.9 6740.5 6796.3 6830.2 6886.8 6904.1 6680.1 6829.6 6837.7 6860.0 6902.3 6327.4 6331.1 6353.8 6363.6 6364.8 6926.9 6929.6 6950.2 7033.0 7040.3 6455.9 6630.0 6652.9 6662.6 6748.3 6639.3 6640.9 6671.2 6679.6 6726.6 6615.5 6629.7 6634.3 6735.0 6738.5 6600.5 6708.3 6716.4 6766.7 6767.7 4801.4 4857.5 4859.4 4861.5 4884.0 4391.1 4403.0 4407.0 4409.5 4416.9 6384.1 6399.4 6401.2 6495.2 6505.2 6671.8 6779.1 6782.0 6810.3 6835.4 6386.8 6435.1 6456.7 6457.9 6459.2 5438.5 5519.0 5521.1 5532.4 5536.2 7040.3 7107.5 7189.0 7197.1 7219.0 6610.0 6729.8 6768.3 6781.9 6810.6 7053.1 7086.1 7087.5 7089.5 7203.3 6646.2 6699.4 6705.1 6795.5 6807.9 6677.2 6812.2 6824.2 6908.6 6917.3 6538.7 6639.0 6651.7 6665.7 6679.7 6497.3 6605.2 6677.3 6681.9 6697.1 6586.4 6593.5 6606.5 6691.9 6693.7 6610.1 6670.0 6671.3 6689.4 6748.1 6440.4 6445.5 6524.5 6533.5 6541.4 06:17:10 INFO - PID 5554 | 06:17:10 INFO - PID 5554 | [#1] ext.html Cycles:180 Average:41774.58 Median:34839.83 stddev:62890.80 (180.5%) stddev-sans-first:62992.29 06:17:10 INFO - PID 5554 | Values: 888.2 901.6 930.2 950.6 950.6 34167.8 34832.7 42433.0 43319.4 43353.3 42784.4 43365.8 43416.3 43417.0 43561.6 7607.4 7695.0 7729.7 7747.7 7750.1 7531.1 7659.2 7662.5 7667.0 7669.3 7704.2 7729.8 7740.2 7744.0 7746.7 7610.1 7621.2 7654.3 7662.6 7676.5 7415.5 7472.4 7477.6 7495.6 7499.5 37560.0 38053.0 38057.4 38137.6 38142.4 3433.1 3438.0 3444.6 3469.2 3469.6 30780.8 30958.7 31132.0 31161.2 31195.2 5087.4 5102.8 5131.5 5159.2 5160.6 195024.0 196156.0 196645.0 196688.0 196859.0 49517.8 49550.5 49581.8 49604.5 49655.8 52713.0 52752.0 52828.7 52844.0 52878.7 16416.0 16781.4 16784.7 16837.7 16876.0 13763.3 13781.2 13790.7 13791.9 13798.1 14106.7 14245.5 14351.9 14407.2 14475.7 5633.5 5740.7 5787.3 5820.1 5843.4 1059.0 1066.6 1075.0 1078.2 1085.0 24280.6 24353.9 31681.4 31888.4 32697.2 1152.9 1155.9 1164.9 1168.2 1189.0 13452.4 13623.7 13644.0 13795.9 13797.2 280342.0 281412.0 281665.0 292268.0 297142.0 59827.1 59853.4 59930.7 60102.0 60153.0 1455.6 1505.1 1514.2 1514.9 1520.3 28659.7 28664.0 28994.0 29651.3 30555.7 52815.7 52998.5 52999.0 53050.7 53073.0 232657.0 232759.0 232946.0 233526.0 233920.0 35245.6 35786.8 36096.8 36114.0 36137.5 44093.0 44602.1 45091.3 45101.0 45371.8 34010.5 34112.5 34322.8 34431.8 34519.5 34067.8 34193.5 34281.0 34714.3 34847.0 37642.6 38913.4 39036.0 39245.4 39308.8 32984.7 32997.5 33040.2 33288.8 33674.5 24086.2 25163.2 25182.5 25420.0 25767.9 06:17:10 INFO - PID 5554 | 06:17:10 INFO - PID 5554 | [#2] jquery.html Cycles:180 Average:40908.21 Median:23253.09 stddev:105009.66 (451.6%) stddev-sans-first:105260.54 06:17:10 INFO - PID 5554 | Values: 556.5 558.9 568.6 584.9 599.6 23272.9 24056.6 24110.3 24140.2 24159.4 25423.7 27567.2 27724.2 27729.6 27853.0 6190.3 6342.1 6343.5 6355.3 6356.1 5916.9 6134.8 6182.8 6322.7 6362.0 6101.5 6112.7 6116.6 6119.9 6121.5 6117.2 6122.8 6133.4 6138.0 6138.3 5703.6 5718.7 5719.1 5720.2 5726.3 30286.2 30685.7 30770.2 30847.0 31322.7 2194.8 2236.1 2236.7 2243.4 2243.9 19769.2 20593.9 20605.6 20612.5 20622.7 2444.6 2506.4 2537.1 2537.3 2563.3 152242.0 156552.0 157949.2 158632.0 158788.0 14995.6 15320.5 15354.2 15800.1 15864.7 23607.5 23965.2 24694.9 24705.5 24781.4 10523.6 10776.8 10893.5 10981.9 10990.9 9849.6 9946.2 9984.1 10025.2 10040.1 9829.6 9929.9 9972.4 10329.0 10365.9 2618.9 2630.2 2681.0 2752.2 2753.7 1021.8 1036.8 1045.6 1049.6 1052.3 21497.4 21639.8 22100.8 22378.1 22585.1 1115.9 1126.2 1131.2 1149.7 1167.4 11539.5 12156.3 12332.4 12352.4 12360.8 622046.0 625352.0 626866.0 628635.0 632517.0 131706.0 132435.0 134701.0 135281.3 139384.0 1298.2 1305.3 1336.9 1342.6 1344.2 23115.4 23233.3 23317.2 23619.2 23928.8 64281.0 64785.7 65028.0 67713.7 67888.3 79506.0 81966.6 83802.0 84029.6 84440.0 14196.9 14950.5 14954.9 15089.1 15306.4 25001.2 25010.0 25070.2 25150.1 25439.1 19058.3 19263.2 19379.0 19557.0 19560.5 17868.0 17896.0 18274.5 18375.4 18521.2 19308.3 19510.3 20154.8 20414.5 20478.7 14985.7 15043.5 15191.6 15195.3 15279.7 19726.3 19754.3 19946.5 20138.7 20175.3 06:17:10 INFO - PID 5554 | 06:17:10 INFO - PID 5554 | [#3] mootools.html Cycles:180 Average:9979.56 Median:2606.35 stddev:7430.56 (285.1%) stddev-sans-first:7423.92 06:17:10 INFO - PID 5554 | Values: 1472.4 1477.4 1482.6 1522.6 1528.9 15498.2 16114.0 16156.7 16160.8 16637.4 16440.4 16712.1 16719.7 16724.3 16726.7 2657.7 2706.8 2725.8 2743.6 2747.1 2677.6 2718.8 2721.1 2721.5 2724.4 2648.8 2687.3 2688.7 2692.5 2757.5 2483.2 2513.9 2515.3 2592.1 2620.6 2443.4 2447.6 2457.3 2467.2 2490.4 15510.9 15680.8 15698.4 15701.0 15740.2 8271.0 8547.3 8548.7 8555.6 8574.5 5046.8 5289.7 5305.4 5379.9 5544.8 1938.9 1940.8 1957.1 2007.7 2407.4 28991.7 29376.0 29409.9 29420.7 29432.3 7065.5 7069.9 7148.3 7216.4 7327.2 18776.9 18796.4 18799.3 18816.4 18836.1 8359.2 8436.5 8513.2 8517.6 8524.1 7732.7 7790.1 7954.2 7955.0 7986.1 4921.6 5178.5 5187.4 5212.8 5243.1 1466.2 1477.2 1498.6 1508.8 1512.9 921.4 947.2 962.7 964.1 968.1 8059.9 8082.9 8191.4 8197.7 8222.2 723.9 738.8 742.4 1008.3 1024.8 5388.6 6212.2 6253.2 6266.6 6294.3 23627.2 24189.2 24210.9 24243.5 24260.0 23716.0 24032.5 24037.2 24248.0 24457.1 12545.9 12649.6 12665.4 12673.0 12959.5 9308.2 9327.8 9424.8 9546.0 9654.5 19862.3 21048.4 21290.4 21319.4 21352.0 20932.3 21205.5 21326.3 21350.4 21751.3 12194.3 12461.9 12495.2 12503.1 12521.9 13636.5 13701.2 13767.7 13859.9 13923.6 11006.8 11173.5 11200.3 11304.7 11427.7 10472.3 10619.4 10701.1 10834.9 10881.1 8744.8 8767.3 8870.8 8880.0 9019.7 8124.6 8134.3 8148.4 8236.8 8398.4 8041.7 8142.6 8180.1 8204.5 8224.3 06:17:10 INFO - PID 5554 | 06:17:10 INFO - PID 5554 | [#4] prototype.html Cycles:180 Average:5560.93 Median:6219.86 stddev:1580.75 (25.4%) stddev-sans-first:1538.98 06:17:10 INFO - PID 5554 | Values: 505.9 525.6 534.2 537.6 539.7 6131.1 6172.5 6182.4 6239.9 6287.7 6095.9 6113.2 6128.4 6135.5 6163.4 4875.8 4915.9 4925.7 4929.0 4938.6 4650.2 4841.5 4856.6 4884.6 4967.6 4742.4 4752.4 4769.4 4785.4 4808.9 4764.5 4771.9 4793.9 4806.2 4813.2 4355.6 4362.0 4368.8 4376.9 4397.3 5979.1 6067.7 6076.8 6081.5 6101.5 5677.0 5703.3 5719.1 5749.2 5754.2 6517.3 6531.5 6566.5 6600.6 6628.9 4900.9 4912.4 4923.6 4933.0 4946.9 6519.4 6666.4 6762.5 6789.7 6820.5 4985.9 5031.7 5032.2 5041.6 5088.6 5117.7 5123.2 5135.9 5137.4 5180.2 5712.2 5725.5 5728.1 5733.4 5755.4 6503.9 6542.6 6566.8 6626.5 6628.4 1785.5 1790.8 1800.4 1802.3 1803.6 1210.5 1242.5 1251.9 1255.9 1262.0 6266.6 6319.3 6323.8 6332.3 6358.6 6781.4 6788.2 6795.6 6816.6 6837.6 6151.5 6172.8 6199.8 6252.3 6277.4 3516.1 3539.2 3546.2 3553.4 3555.7 6921.2 6965.4 6987.9 6988.9 7107.7 6489.6 6754.2 6755.5 6767.6 6845.9 6943.8 6958.5 6988.5 6994.0 7063.3 6581.4 6623.3 6653.7 6692.6 6722.5 6569.3 6572.5 6575.5 6621.9 6669.3 6946.3 6977.5 7019.8 7027.4 7051.3 5044.8 5067.7 5083.9 5086.4 5102.2 6517.6 6585.5 6676.4 6702.0 6830.3 6450.0 6460.7 6466.9 6553.4 6557.2 6426.8 6429.4 6431.6 6590.9 6622.3 6445.6 6485.9 6509.6 6513.6 6542.8 6560.5 6620.3 6626.4 6676.2 6686.5 6386.7 6399.5 6430.4 6431.6 6464.7 06:17:10 INFO - PID 5554 | 06:17:10 INFO - PID 5554 | [#5] yui.html Cycles:180 Average:27558.43 Median:20719.29 stddev:39698.35 (191.6%) stddev-sans-first:39759.36 06:17:10 INFO - PID 5554 | Values: 929.3 941.3 954.3 955.5 970.1 19115.7 19632.0 19772.8 19779.2 22854.8 22274.3 22785.5 22885.8 22907.7 23078.5 1043.7 1069.7 1069.9 1070.2 1073.8 1029.3 1063.3 1064.9 1065.0 1065.2 1121.4 1122.7 1123.0 1123.1 1126.5 1117.7 1118.9 1120.3 1120.6 1128.0 822.0 822.7 822.7 823.1 826.7 20801.7 20916.8 20960.7 21097.8 21315.8 22705.9 22912.3 23112.4 23516.2 23625.2 16995.0 17107.0 17224.9 17586.2 17881.2 3820.8 3827.7 3829.8 3831.3 3855.6 157743.0 158941.2 159562.0 159712.0 160024.0 17324.0 17484.7 17828.2 17932.7 17935.2 33368.7 33874.5 33975.0 34068.5 34303.8 8432.5 8446.7 8462.0 8693.0 8791.4 4493.3 4521.8 4528.5 4531.4 4534.1 5619.0 5711.2 5731.3 5739.3 5763.2 1135.4 1157.9 1167.0 1170.5 1173.3 724.7 725.2 736.6 747.4 751.2 13485.9 13573.9 13680.5 14301.1 14521.3 707.3 709.1 712.0 713.9 715.4 6184.0 6241.3 6393.9 6424.3 6442.6 135007.0 136039.3 137328.0 138083.3 141820.0 121358.0 122061.4 122638.0 123858.0 124753.0 102635.0 104056.0 104155.0 104574.5 106220.5 11827.5 11926.5 11928.2 11984.5 12141.0 49844.8 50171.2 50839.5 50922.7 51904.0 63415.0 63640.7 63649.0 63987.0 64267.0 16263.2 16493.9 17042.7 17131.8 17138.2 19765.9 20138.8 24034.8 24495.3 24641.6 20800.6 21420.5 21447.2 22245.2 22509.3 20609.9 20638.0 20920.5 20964.3 21038.6 19921.1 20010.2 20401.9 21312.6 22341.7 15247.8 15441.5 15561.0 15874.4 15887.2 14837.6 14924.9 15482.7 15572.4 15837.5 06:17:10 INFO - PID 5554 | -------- Summary: end -------- 06:17:10 INFO - PID 5554 | 06:17:11 INFO - TEST-INFO | 5554: exit 0 06:17:11 INFO - TEST-OK | dromaeo_css | took 1109611ms 06:17:11 INFO - TEST-START | kraken 06:17:11 INFO - Initialising browser for kraken test... 06:17:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48147/getInfo.html -profile /tmp/tmpEMCEzU/profile 06:17:11 INFO - TEST-INFO | started process 5971 (/builds/slave/test/build/application/firefox/firefox http://localhost:48147/getInfo.html) 06:17:17 INFO - TEST-INFO | 5971: exit 0 06:17:17 INFO - Browser initialized. 06:17:17 INFO - Running cycle 1/1 for kraken test... 06:17:17 INFO - TEST-INFO | started process 6146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEMCEzU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:17:18 INFO - PID 6146 | 06:17:18 INFO - PID 6146 | (/builds/slave/test/build/application/firefox/firefox:6196): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:17:18 INFO - PID 6146 | 06:17:18 INFO - PID 6146 | 06:17:18 INFO - PID 6146 | (/builds/slave/test/build/application/firefox/firefox:6250): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:17:18 INFO - PID 6146 | 06:17:18 INFO - PID 6146 | __metrics Screen width/height:1600/1200 06:17:18 INFO - PID 6146 | colorDepth:24 06:17:18 INFO - PID 6146 | Browser inner width/height: 1024/768 06:17:18 INFO - PID 6146 | __metrics 06:17:28 INFO - PID 6146 | RSS: Main: 165781504 06:17:28 INFO - PID 6146 | 06:17:30 INFO - PID 6146 | Cycle 1(1): loaded http://localhost:48147/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48147/tests/kraken/driver.html?testName=audio-beat-detection) 06:17:31 INFO - PID 6146 | RSS: Main: 169787392 06:17:31 INFO - PID 6146 | 06:17:34 INFO - PID 6146 | Cycle 1(1): loaded http://localhost:48147/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48147/tests/kraken/driver.html?testName=audio-dft) 06:17:35 INFO - PID 6146 | RSS: Main: 172044288 06:17:35 INFO - PID 6146 | 06:17:37 INFO - PID 6146 | Cycle 1(1): loaded http://localhost:48147/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48147/tests/kraken/driver.html?testName=audio-fft) 06:17:38 INFO - PID 6146 | RSS: Main: 165556224 06:17:38 INFO - PID 6146 | 06:17:40 INFO - PID 6146 | Cycle 1(1): loaded http://localhost:48147/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48147/tests/kraken/driver.html?testName=audio-oscillator) 06:17:41 INFO - PID 6146 | RSS: Main: 166756352 06:17:41 INFO - PID 6146 | 06:17:43 INFO - PID 6146 | Cycle 1(1): loaded http://localhost:48147/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48147/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:17:44 INFO - PID 6146 | RSS: Main: 166604800 06:17:44 INFO - PID 6146 | 06:17:47 INFO - PID 6146 | Cycle 1(1): loaded http://localhost:48147/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48147/tests/kraken/driver.html?testName=imaging-darkroom) 06:17:47 INFO - PID 6146 | RSS: Main: 167976960 06:17:47 INFO - PID 6146 | 06:17:51 INFO - PID 6146 | Cycle 1(1): loaded http://localhost:48147/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48147/tests/kraken/driver.html?testName=imaging-desaturate) 06:17:51 INFO - PID 6146 | RSS: Main: 169885696 06:17:51 INFO - PID 6146 | 06:17:54 INFO - PID 6146 | Cycle 1(1): loaded http://localhost:48147/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48147/tests/kraken/driver.html?testName=json-parse-financial) 06:17:55 INFO - PID 6146 | RSS: Main: 168665088 06:17:55 INFO - PID 6146 | 06:17:56 INFO - PID 6146 | Cycle 1(1): loaded http://localhost:48147/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48147/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:17:57 INFO - PID 6146 | RSS: Main: 168407040 06:17:57 INFO - PID 6146 | 06:17:58 INFO - PID 6146 | Cycle 1(1): loaded http://localhost:48147/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48147/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:17:59 INFO - PID 6146 | RSS: Main: 168652800 06:17:59 INFO - PID 6146 | 06:18:01 INFO - PID 6146 | Cycle 1(1): loaded http://localhost:48147/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48147/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:02 INFO - PID 6146 | RSS: Main: 169000960 06:18:02 INFO - PID 6146 | 06:18:04 INFO - PID 6146 | Cycle 1(1): loaded http://localhost:48147/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:05 INFO - PID 6146 | RSS: Main: 168534016 06:18:05 INFO - PID 6146 | 06:18:08 INFO - PID 6146 | Cycle 1(1): loaded http://localhost:48147/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:18:08 INFO - PID 6146 | RSS: Main: 168816640 06:18:08 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | Cycle 1(1): loaded http://localhost:48147/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48147/tests/kraken/driver.html?testName=ai-astar) 06:18:10 INFO - PID 6146 | RSS: Main: 170577920 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | __start_tp_report 06:18:10 INFO - PID 6146 | _x_x_mozilla_page_load 06:18:10 INFO - PID 6146 | _x_x_mozilla_page_load_details 06:18:10 INFO - PID 6146 | |i|pagename|runs| 06:18:10 INFO - PID 6146 | |0;ai-astar;98;119;97;105;113;107;109;98;106;107 06:18:10 INFO - PID 6146 | |1;audio-beat-detection;139;124;144;163;113;137;142;113;182;126 06:18:10 INFO - PID 6146 | |2;audio-dft;164;164;162;162;161;161;161;162;169;171 06:18:10 INFO - PID 6146 | |3;audio-fft;74;74;76;155;74;73;72;92;94;74 06:18:10 INFO - PID 6146 | |4;audio-oscillator;78;78;139;79;78;78;125;78;78;130 06:18:10 INFO - PID 6146 | |5;imaging-gaussian-blur;114;114;114;115;113;115;114;113;114;113 06:18:10 INFO - PID 6146 | |6;imaging-darkroom;147;147;147;148;148;147;147;148;147;148 06:18:10 INFO - PID 6146 | |7;imaging-desaturate;101;95;94;93;94;94;93;94;93;94 06:18:10 INFO - PID 6146 | |8;json-parse-financial;48;49;49;48;50;49;52;48;48;48 06:18:10 INFO - PID 6146 | |9;json-stringify-tinderbox;54;54;59;60;54;54;54;54;58;58 06:18:10 INFO - PID 6146 | |10;stanford-crypto-aes;76;72;72;72;77;73;71;72;72;73 06:18:10 INFO - PID 6146 | |11;stanford-crypto-ccm;121;112;119;120;109;113;113;117;114;158 06:18:10 INFO - PID 6146 | |12;stanford-crypto-pbkdf2;161;161;167;175;171;166;176;159;160;173 06:18:10 INFO - PID 6146 | |13;stanford-crypto-sha256-iterative;61;61;66;67;61;59;59;62;59;61 06:18:10 INFO - PID 6146 | __end_tp_report 06:18:10 INFO - PID 6146 | __start_cc_report 06:18:10 INFO - PID 6146 | _x_x_mozilla_cycle_collect,874 06:18:10 INFO - PID 6146 | __end_cc_report 06:18:10 INFO - PID 6146 | __startTimestamp1503321490892__endTimestamp 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | ------- Summary: start ------- 06:18:10 INFO - PID 6146 | Number of tests: 14 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | [#0] ai-astar Cycles:10 Average:105.90 Median:116.00 stddev:6.98 (6.0%) stddev-sans-first:6.80 06:18:10 INFO - PID 6146 | Values: 98.0 119.0 97.0 105.0 113.0 107.0 109.0 98.0 106.0 107.0 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:140.50 stddev:21.61 (15.4%) stddev-sans-first:22.92 06:18:10 INFO - PID 6146 | Values: 139.0 124.0 144.0 163.0 113.0 137.0 142.0 113.0 182.0 126.0 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.53 (2.2%) stddev-sans-first:3.74 06:18:10 INFO - PID 6146 | Values: 164.0 164.0 162.0 162.0 161.0 161.0 161.0 162.0 169.0 171.0 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | [#3] audio-fft Cycles:10 Average:85.80 Median:74.00 stddev:25.61 (34.6%) stddev-sans-first:26.80 06:18:10 INFO - PID 6146 | Values: 74.0 74.0 76.0 155.0 74.0 73.0 72.0 92.0 94.0 74.0 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:78.00 stddev:25.91 (33.2%) stddev-sans-first:26.82 06:18:10 INFO - PID 6146 | Values: 78.0 78.0 139.0 79.0 78.0 78.0 125.0 78.0 78.0 130.0 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 06:18:10 INFO - PID 6146 | Values: 114.0 114.0 114.0 115.0 113.0 115.0 114.0 113.0 114.0 113.0 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:18:10 INFO - PID 6146 | Values: 147.0 147.0 147.0 148.0 148.0 147.0 147.0 148.0 147.0 148.0 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:2.37 (2.5%) stddev-sans-first:0.67 06:18:10 INFO - PID 6146 | Values: 101.0 95.0 94.0 93.0 94.0 94.0 93.0 94.0 93.0 94.0 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | [#8] json-parse-financial Cycles:10 Average:48.90 Median:49.00 stddev:1.29 (2.6%) stddev-sans-first:1.32 06:18:10 INFO - PID 6146 | Values: 48.0 49.0 49.0 48.0 50.0 49.0 52.0 48.0 48.0 48.0 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:2.51 (4.5%) stddev-sans-first:2.57 06:18:10 INFO - PID 6146 | Values: 54.0 54.0 59.0 60.0 54.0 54.0 54.0 54.0 58.0 58.0 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:72.50 stddev:1.94 (2.7%) stddev-sans-first:1.73 06:18:10 INFO - PID 6146 | Values: 76.0 72.0 72.0 72.0 77.0 73.0 71.0 72.0 72.0 73.0 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:118.00 stddev:14.03 (11.9%) stddev-sans-first:14.88 06:18:10 INFO - PID 6146 | Values: 121.0 112.0 119.0 120.0 109.0 113.0 113.0 117.0 114.0 158.0 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:169.00 stddev:6.52 (3.9%) stddev-sans-first:6.56 06:18:10 INFO - PID 6146 | Values: 161.0 161.0 167.0 175.0 171.0 166.0 176.0 159.0 160.0 173.0 06:18:10 INFO - PID 6146 | 06:18:10 INFO - PID 6146 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:61.00 stddev:2.80 (4.6%) stddev-sans-first:2.96 06:18:10 INFO - PID 6146 | Values: 61.0 61.0 66.0 67.0 61.0 59.0 59.0 62.0 59.0 61.0 06:18:10 INFO - PID 6146 | -------- Summary: end -------- 06:18:10 INFO - PID 6146 | 06:18:11 INFO - PID 6146 | 06:18:11 INFO - PID 6146 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 06:18:11 INFO - PID 6146 | 06:18:11 INFO - PID 6146 | 06:18:11 INFO - PID 6146 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 06:18:11 INFO - PID 6146 | 06:18:11 INFO - PID 6146 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:18:11 INFO - TEST-INFO | 6146: exit 0 06:18:11 INFO - TEST-OK | kraken | took 60673ms 06:18:11 INFO - SUITE-END | took 1170s 06:18:12 INFO - Completed test suite (00:19:30) 06:18:12 INFO - javascript benchmark 06:18:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8943.125296604621, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3486.9651303486958, 3511.034465521982, 3537.3809583322914, 3538.23927855511, 3544.4151714967034, 6122.908156377658, 6177.598456100356, 6213.813585592434, 6216.347283535231, 6249.218847644044, 6187.721552530147, 6220.440160385564, 6245.531585131111, 6246.781362652308, 6281.528885333595, 5518.227448157241, 5539.944600553983, 5548.500634942854, 5568.3596386415475, 5574.1638754187, 5387.919181212285, 5399.595030372718, 5484.067708489546, 5487.98472282627, 5561.860953476155, 5459.836204913859, 5460.945390546103, 5497.945020549783, 5555.972220138873, 5563.860903477425, 5485.588580856412, 5491.956528259658, 5520.144377621435, 5551.639143455663, 5581.302337207849, 5372.54333381663, 5431.972840135813, 5449.64577302478, 5520.751566179491, 5536.833894983157, 6115.755369785204, 6180.0, 6197.194364732601, 6213.471854892339, 6216.906746398808, 6740.460763138986, 6796.286389929085, 6830.248672646005, 6886.793396198072, 6904.067950826624, 6680.098186744776, 6829.556078854858, 6837.726490940357, 6860.03959445678, 6902.275261097613, 6327.430531252209, 6331.081993111019, 6353.809385718436, 6363.61818290904, 6364.77723279683, 6926.861462770717, 6929.5842249465195, 6950.200726916368, 7033.0, 7040.331168538981, 6455.903161452582, 6629.966850165718, 6652.933470665232, 6662.56693314933, 6748.29142939994, 6639.269680335159, 6640.933590664128, 6671.232808227019, 6679.632620205838, 6726.562773419712, 6615.470762339001, 6629.668516574152, 6634.336566343423, 6735.0, 6738.494612904052, 6600.5049621278595, 6708.3291670833505, 6716.429103526255, 6766.661666916634, 6767.661616919135, 4801.423829140525, 4857.53853383928, 4859.416869975626, 4861.538153875376, 4884.023195360942, 4391.055922976575, 4403.0, 4407.030453300269, 4409.5149533551285, 4416.933745993812, 6384.138141350858, 6399.392057754506, 6401.199850018747, 6495.155629768195, 6505.154329937078, 6671.833204169838, 6779.118714567173, 6782.016607591971, 6810.318968103249, 6835.350641689031, 6386.808395748135, 6435.099086127946, 6456.741730330734, 6457.870842583122, 6459.192600924885, 5438.45615438453, 5518.972405138029, 5521.116621340566, 5532.3914369419335, 5536.169574563767, 7040.260772618802, 7107.538010029331, 7189.029481019996, 7197.136343638692, 7218.963905180441, 6610.0, 6729.764458243938, 6768.323167683291, 6781.898271525833, 6810.5913645181445, 7053.0830991970715, 7086.149662040588, 7087.468439866928, 7089.468289878177, 7203.279672032964, 6646.2356828965285, 6699.363560461748, 6705.1283333166375, 6795.524313298021, 6807.897881531682, 6677.232118306457, 6812.216595091628, 6824.18109826824, 6908.5509441886115, 6917.342852429011, 6538.673066346569, 6639.0, 6651.667416629246, 6665.700043497957, 6679.6994135265, 6497.31778163305, 6605.240397354173, 6677.332266773284, 6681.866362672817, 6697.09589205451, 6586.4401525868925, 6593.538452308292, 6606.471482281502, 6691.933080669326, 6693.698783554849, 6610.10763546915, 6670.0, 6671.266160722414, 6689.431398331197, 6748.122744043243, 6440.35596440371, 6445.548811583331, 6524.543281970216, 6533.509986751108, 6541.378569035934], "value": 6160.974364196165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.1591961071331, 901.589776651624, 930.1767935377192, 950.5864948747295, 950.6245033211877, 34167.82916085419, 34832.651673483255, 42433.0, 43319.35020974688, 43353.34969975445, 42784.3582346265, 43365.78317108418, 43416.34875476862, 43417.0, 43561.56438435615, 7607.429442791785, 7695.038120234971, 7729.72945946892, 7747.690092396298, 7750.108737495204, 7531.096268447794, 7659.195784442637, 7662.501937374081, 7667.0, 7669.309762121408, 7704.152543220242, 7729.806754831118, 7740.225977402271, 7744.0, 7746.651400686983, 7610.124835643889, 7621.161672216052, 7654.272844079831, 7662.578558179298, 7676.46264761467, 7415.480916335859, 7472.364848987842, 7477.626118694098, 7495.625218739041, 7499.512531685423, 37560.0, 38053.0, 38057.42913856294, 38137.61862381369, 38142.42786358207, 3433.141714571357, 3437.9656203437894, 3444.603870554868, 3469.1847415857255, 3469.6356882527225, 30780.8460957696, 30958.690413095806, 31132.0, 31161.22096947572, 31195.220119496968, 5087.414947281073, 5102.795888164469, 5131.538161565477, 5159.2003239497935, 5160.612954028463, 195024.0, 196156.0192199044, 196645.0, 196688.0, 196859.0, 49517.752411237714, 49550.50449495531, 49581.752091239316, 49604.50395495999, 49655.75172124188, 52713.0, 52752.0, 52828.73585632124, 52844.0, 52878.735606322494, 16416.0, 16781.412650557173, 16784.664306714043, 16837.747433788503, 16876.0, 13763.31183440824, 13781.173129612054, 13790.65523361924, 13791.862081379259, 13798.103123296954, 14106.71786564263, 14245.501407450689, 14351.856481435261, 14407.207603581694, 14475.710485790225, 5633.549316054706, 5740.712964351766, 5787.305523337142, 5820.097884827858, 5843.357230704619, 1058.9523471443804, 1066.6053560182781, 1075.0485820049312, 1078.2344535379812, 1084.9945750271197, 24280.63579046316, 24353.878230608734, 31681.366372672877, 31888.362232755215, 32697.182570435452, 1152.8817047463947, 1155.9075273978062, 1164.9242799218023, 1168.1822724093, 1189.0, 13452.394642241123, 13623.659408514866, 13644.0, 13795.931020344835, 13797.172169669851, 280342.0, 281412.0, 281665.0, 292268.0, 297142.0, 59827.10259346113, 59853.40146598478, 59930.700346497986, 60102.0, 60153.0, 1455.5560554031122, 1505.0819000409742, 1514.1596413990342, 1514.8560886715745, 1520.3006616956102, 28659.713402865706, 28664.0, 28994.0, 29651.258718532208, 30555.694443056174, 52815.73592132015, 52998.470015299354, 52999.0, 53050.73474632602, 53073.0, 232657.0, 232759.0, 232946.0, 233526.0, 233920.0, 35245.64754352424, 35786.8210658945, 36096.81951590225, 36114.0, 36137.45793813042, 44093.0, 44602.10795784131, 45091.32363014623, 45101.0, 45371.77314113409, 34010.489842652874, 34112.48831267483, 34322.82838585791, 34431.827840860635, 34519.4822077674, 34067.82966085154, 34193.487097693054, 34281.0, 34714.30571388609, 34847.0, 37642.623573763914, 38913.41629875497, 39036.0, 39245.41131883081, 39308.80345598254, 32984.67015329816, 32997.50503742494, 33040.1739956503, 33288.83355583207, 33674.49488257629, 24086.15698450546, 25163.24510264695, 25182.461696781644, 25420.0, 25767.871160644077], "value": 18221.8900948926, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.4824713016893, 558.8714595643002, 568.5508448325822, 584.8859472402881, 599.625234228607, 23272.88363558182, 24056.639150412757, 24110.276691699255, 24140.15509457169, 24159.39601509963, 25423.74576254237, 27567.172984810488, 27724.168274951735, 27729.58405623917, 27853.02514411996, 6190.3190649028575, 6342.112104305401, 6343.524235682342, 6355.3009168991375, 6356.141920840673, 5916.911246331309, 6134.8159555213415, 6182.783602573911, 6322.652254126021, 6362.0, 6101.511879049687, 6112.694365281718, 6116.633002019893, 6119.938800612003, 6121.479674227674, 6117.174181485487, 6122.785702500413, 6133.355997620275, 6137.969310153465, 6138.324784273726, 5703.62926409782, 5718.714064296769, 5719.056355701346, 5720.170575266605, 5726.31284245889, 30286.242843928856, 30685.69314306873, 30770.23074423135, 30847.0, 31322.686773132205, 2194.8353873459396, 2236.0608544411384, 2236.686863839064, 2243.4391402149463, 2243.887805609713, 19769.209231630717, 20593.8970305149, 20605.587888242153, 20612.484687882923, 20622.690659640117, 2444.5966415541416, 2506.385935445809, 2537.0612873236837, 2537.251510804317, 2563.2566555698827, 152242.0, 156552.0, 157949.21025394913, 158632.0, 158788.0, 14995.625109372353, 15320.548712205993, 15354.155521446204, 15800.130992795277, 15864.682706345808, 23607.527849442915, 23965.16121935759, 24694.876525617256, 24705.5058898821, 24781.380465488146, 10523.631672891412, 10776.838347424795, 10893.455327233607, 10981.890181098246, 10990.945045274882, 9849.60601575929, 9946.20430365569, 9984.101430871257, 10025.24810639205, 10040.096391324816, 9829.606815727291, 9929.900700993043, 9972.401655900669, 10329.0, 10365.9481702591, 2618.947621047568, 2630.213530233456, 2681.002653023471, 2752.2018614601543, 2753.7317158404794, 1021.8467229915424, 1036.7667274863095, 1045.6444808764904, 1049.6483677967967, 1052.321252791945, 21497.355079347646, 21639.78360216409, 22100.778992210195, 22378.10487580511, 22585.093838066798, 1115.8772535021142, 1126.2060247525476, 1131.1685910855515, 1149.6665966869514, 1167.4337946096136, 11539.538418463335, 12156.270623762426, 12332.445039973223, 12352.44414001372, 12360.814587781191, 622046.0, 625352.0, 626866.0, 628635.0, 632517.0, 131706.0, 132435.0, 134701.0, 135281.3235933814, 139384.0, 1298.1756584568866, 1305.3147097773556, 1336.8596297388633, 1342.5703774792169, 1344.2069179184327, 23115.422114447272, 23233.30300091, 23317.183898564148, 23619.173328933404, 23928.760712392654, 64281.0, 64785.67607161934, 65028.0, 67713.66143169253, 67888.32111679018, 79506.0, 81966.59016705117, 83802.0, 84029.57985210035, 84440.0, 14196.858031419553, 14950.476733314283, 14954.850451495346, 15089.094654320776, 15306.387744490541, 25001.249962501155, 25010.0, 25070.247892563253, 25150.11974580881, 25439.10963116282, 19058.332958346393, 19263.22947082101, 19379.0, 19557.0, 19560.510987225432, 17868.0, 17896.0, 18274.45176644703, 18375.356862509747, 18521.166547505127, 19308.32420865263, 19510.31713890007, 20154.798452015293, 20414.489637759176, 20478.692819608015, 14985.700285994437, 15043.548693539211, 15191.620209494851, 15195.316210770763, 15279.694406112038, 19726.30957916466, 19754.308599198957, 19946.501337466678, 20138.697919530925, 20175.293864714666], "value": 12786.010545021622, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1472.352165047379, 1477.416420513897, 1482.5996980815187, 1522.588900996731, 1528.9006214596047, 15498.22508874556, 16114.033158010512, 16156.676866462663, 16160.83839161608, 16637.41769038084, 16440.42458513952, 16712.08083555404, 16719.749203761952, 16724.331026758944, 16726.74909876353, 2657.6943651480037, 2706.796990225736, 2725.7683096936785, 2743.6158937748733, 2747.093459158473, 2677.571588545833, 2718.8232764870318, 2721.1020363280168, 2721.537338652434, 2724.359775452777, 2648.827826191301, 2687.261003224119, 2688.6639170103736, 2692.4749673813612, 2757.5174344489733, 2483.192962287255, 2513.861737604431, 2515.3460100374036, 2592.131635901975, 2620.567606344951, 2443.3769388805918, 2447.559439300925, 2457.348802567321, 2467.161165203839, 2490.3649569359877, 15510.922445387701, 15680.843191568052, 15698.37206511738, 15701.0, 15740.212989350486, 8270.958645206796, 8547.273481754059, 8548.74353769388, 8555.572221388906, 8574.528400937947, 5046.848594542133, 5289.709066001368, 5305.3898801637915, 5379.865503362408, 5544.833654990357, 1938.903054847252, 1940.8253257206777, 1957.1388589020785, 2007.6586980213253, 2407.3861165402886, 28991.710082899113, 29376.0, 29409.852950735323, 29420.70579294201, 29432.264193395124, 7065.4700897432895, 7069.852095758631, 7148.320909513588, 7216.386607138347, 7327.194008659043, 18776.90611546961, 18796.436106916815, 18799.342023029403, 18816.435506934813, 18836.05819709009, 8359.247667709935, 8436.45163064399, 8513.19124683154, 8517.57412129391, 8524.104968978168, 7732.6520306586335, 7790.143084260727, 7954.244346787046, 7955.0, 7986.081600616004, 4921.581665558396, 5178.508041736029, 5187.429382767892, 5212.765425555859, 5243.082460569385, 1466.2375564706292, 1477.1949287638263, 1498.5654160293393, 1508.7736839473948, 1512.9319180636899, 921.3780698028804, 947.1806887042796, 962.7208109648263, 964.0696727657844, 968.1431932739576, 8059.919400805917, 8082.878756818534, 8191.385646076568, 8197.672093116327, 8222.17778222173, 723.9058922340062, 738.8448425830636, 742.4023660952877, 1008.2639673038723, 1024.7694268789462, 5388.622796404214, 6212.192414986023, 6253.155823963707, 6266.621343304466, 6294.271404912527, 23627.173048943205, 24189.15337963198, 24210.87894560516, 24243.51512969766, 24260.02959881585, 23716.0, 24032.51934961291, 24037.158699445434, 24248.0, 24457.143999959917, 12545.93727031359, 12649.557265495847, 12665.430055647517, 12673.0, 12959.546415875398, 9308.162265396148, 9327.766805829637, 9424.764380890532, 9545.952270238604, 9654.469004204837, 19862.304819331253, 21048.368548943556, 21290.36128916135, 21319.360419187447, 21352.0, 20932.267370641955, 21205.469863252925, 21326.253581124587, 21350.35948921535, 21751.347459576238, 12194.268343899394, 12461.87538124607, 12495.187812792139, 12503.062270329943, 12521.93739031299, 13636.454541818217, 13701.246431446367, 13767.655808604864, 13859.930700346435, 13923.58229253124, 11006.834897476705, 11173.49719262619, 11200.271982321123, 11304.660860174208, 11427.714307142056, 10472.26694131434, 10619.36283822973, 10701.090407315465, 10834.891651083388, 10881.075108615856, 8744.78138046554, 8767.254783343233, 8870.822583548164, 8880.0, 9019.684311049083, 8124.553149576594, 8134.308583770446, 8148.388870834592, 8236.752897413087, 8398.370122240978, 8041.678332866853, 8142.633581488965, 8180.100188979089, 8204.548749818818, 8224.300934420402], "value": 6967.907419536513, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.863416877443, 525.6399366433991, 534.2307077807956, 537.6263496869675, 539.7355295905005, 6131.141640170368, 6172.475339596134, 6182.381761823815, 6239.937600623993, 6287.685615719219, 6095.939040609593, 6113.187933550561, 6128.356522565134, 6135.509159267259, 6163.445289923906, 4875.829345972892, 4915.877103072416, 4925.679830811004, 4929.0, 4938.555530002299, 4650.209464391045, 4841.491643377448, 4856.611471082305, 4884.633652476061, 4967.627427942919, 4742.359781429497, 4752.382190315254, 4769.427668679746, 4785.353977213066, 4808.879778005543, 4764.547368000034, 4771.928421073687, 4793.856184314476, 4806.158922188621, 4813.181759100961, 4355.60799528044, 4361.978190109061, 4368.847090351855, 4376.868693939187, 4397.318415645548, 5979.133025711291, 6067.696615169268, 6076.848078798022, 6081.452669259744, 6101.450869421729, 5676.971615141898, 5703.31560212773, 5719.113537401709, 5749.223854779593, 5754.1944127822135, 6517.250516190651, 6531.542792004561, 6566.540342176049, 6600.570962887397, 6628.867422651569, 4900.877478063041, 4912.410510738699, 4923.606111511071, 4932.954976918928, 4946.87632809179, 6519.4132528072705, 6666.433353164938, 6762.459003279726, 6789.694463749143, 6820.522563420563, 4985.850424487271, 5031.6729412588065, 5032.169692000852, 5041.571466425395, 5088.618353623419, 5117.667351622133, 5123.154679477844, 5135.897282054338, 5137.434882162959, 5180.1711726124395, 5712.2288491054005, 5725.484706376446, 5728.083506638918, 5733.426657334233, 5755.424457554211, 6503.902441463382, 6542.574732642363, 6566.770163044366, 6626.469882409396, 6628.403443690091, 1785.4732853808157, 1790.8388245058006, 1800.3698705453248, 1802.3241284518306, 1803.5761596024925, 1210.5218438716659, 1242.4657397319058, 1251.8608066659478, 1255.8555766087018, 1261.9871305268082, 6266.624002559861, 6319.304876463585, 6323.810285691345, 6332.271788744261, 6358.632893927827, 6781.423578995742, 6788.151481064867, 6795.558288711218, 6816.625085620339, 6837.589744615239, 6151.507879369729, 6172.783952561639, 6199.783007594712, 6252.280987686383, 6277.403646653652, 3516.1385460562324, 3539.2213712983103, 3546.1666508370513, 3553.4136867417105, 3555.7421037641284, 6921.204061532888, 6965.407940325028, 6987.89518157228, 6988.930110698828, 7107.71569137239, 6489.643069631121, 6754.223264324665, 6755.534230006111, 6767.5672434555445, 6845.8973115403305, 6943.756968506078, 6958.512904096766, 6988.545744526589, 6993.965030174817, 7063.25835787235, 6581.42045908988, 6623.3376662333385, 6653.733850646114, 6692.6319052450635, 6722.529422940347, 6569.277379488157, 6572.474202063919, 6575.473962082926, 6621.9337806621315, 6669.266380698216, 6946.340097690711, 6977.511574189758, 7019.789406317818, 7027.402670772837, 7051.294870513113, 5044.772985215747, 5067.721275329893, 5083.898322033465, 5086.3896332440345, 5102.158143906362, 6517.641529715911, 6585.539012269095, 6676.432503237085, 6702.045792981969, 6830.282820303995, 6450.0, 6460.741570337322, 6466.932956062197, 6553.442957348679, 6557.2131344239, 6426.839329016812, 6429.421352078335, 6431.646259455588, 6590.879550476335, 6622.337766223339, 6445.645489497935, 6485.935140648533, 6509.609423434609, 6513.609183449008, 6542.83642908912, 6560.507961902781, 6620.337966203534, 6626.403623673892, 6676.1988561371, 6686.465082793267, 6386.744530218925, 6399.520035997412, 6430.3891130342545, 6431.614103153825, 6464.676766161767], "value": 5100.200773106591, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [929.2658799548353, 941.3194409857457, 954.2584782771444, 955.5461155950928, 970.1414248390175, 19115.71326430103, 19632.0, 19772.802271977274, 19779.208831646716, 22854.771452285473, 22274.331770046883, 22785.54428911421, 22885.771142288573, 22907.656385154238, 23078.538429231405, 1043.7442826507515, 1069.7432616172102, 1069.9197560183018, 1070.2080460459242, 1073.7691396349783, 1029.3412216181612, 1063.2982231727062, 1064.872215334161, 1064.952077156526, 1065.1851333729703, 1121.4280716834392, 1122.6968718446014, 1122.9943850280738, 1123.0678536814464, 1126.5155982927338, 1117.6870476266658, 1118.9048930840888, 1120.2718233148437, 1120.5517792882831, 1127.9605213817517, 822.0135836995629, 822.7161629237903, 822.7449490657856, 823.074041703084, 826.7189155687036, 20801.687974680393, 20916.790832091636, 20960.685589716013, 21097.78902210989, 21315.78684213169, 22705.886470567708, 22912.31263062111, 23112.42218944523, 23516.176933807405, 23625.173118940755, 16995.0, 17107.0, 17224.913875430542, 17586.208620612102, 17881.195346209453, 3820.789856557888, 3827.6937844972335, 3829.8276577554075, 3831.3295173344554, 3855.575886652466, 157743.0, 158941.2052939728, 159562.0, 159712.0, 160024.0, 17324.0, 17484.737728934077, 17828.197731102133, 17932.731009034876, 17935.192916318796, 33368.66631333656, 33874.49188262178, 33975.0, 34068.48897266543, 34303.82848085744, 8432.45189062709, 8446.704365347183, 8462.026866910384, 8693.00030496501, 8791.428557143765, 4493.303537951622, 4521.84173553924, 4528.50186479487, 4531.388262584509, 4534.070515544306, 5619.016672082369, 5711.200431939532, 5731.254936858265, 5739.311282646109, 5763.164341170591, 1135.4152611405134, 1157.9015783658483, 1166.976660466803, 1170.4849866058908, 1173.313611537243, 724.6702750248625, 725.2493669052611, 736.6206403702098, 747.3572727454385, 751.1849643137148, 13485.932570337085, 13573.932130339284, 13680.452781888813, 14301.141931483937, 14521.273936303143, 707.2538471912079, 709.1206903439697, 711.9679614417364, 713.8685183983341, 715.4348065028569, 6183.96908015466, 6241.313455519889, 6393.9360606394275, 6424.261209960914, 6442.613443193423, 135007.0, 136039.31980340034, 137328.0, 138083.30958345145, 141820.0, 121358.0, 122061.38969305097, 122638.0, 123858.0, 124753.0, 102635.0, 104056.0, 104155.0, 104574.47712761388, 106220.46889765657, 11827.52689892429, 11926.522939082686, 11928.165028448273, 11984.46069926838, 12141.028717702386, 49844.750776245884, 50171.24743128929, 50839.49160508347, 50922.74538627283, 51904.0, 63415.0, 63640.68179659072, 63649.0, 63987.0, 64267.0, 16263.186840658156, 16493.917530412273, 17042.744358834876, 17131.828681713025, 17138.228779704696, 19765.901170494057, 20138.798612013692, 24034.75965240395, 24495.265142045766, 24641.63037554474, 20800.58398832045, 21420.464488387915, 21447.249346272805, 22245.22141725032, 22509.324720258417, 20609.89695051575, 20638.0, 20920.47698807542, 20964.266250681154, 21038.57922841504, 19921.10355033998, 20010.199592016157, 20401.89799050995, 21312.573748525254, 22341.664875026563, 15247.771283430535, 15441.5367538974, 15561.0, 15874.365025398854, 15887.205639717737, 14837.629059273604, 14924.85075149278, 15482.690346193238, 15572.37710491613, 15837.524874253791], "value": 10028.608223665206, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1469.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 119.0, 97.0, 105.0, 113.0, 107.0, 109.0, 98.0, 106.0, 107.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 124.0, 144.0, 163.0, 113.0, 137.0, 142.0, 113.0, 182.0, 126.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 162.0, 161.0, 161.0, 161.0, 162.0, 169.0, 171.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 155.0, 74.0, 73.0, 72.0, 92.0, 94.0, 74.0], "value": 85.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 139.0, 79.0, 78.0, 78.0, 125.0, 78.0, 78.0, 130.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 113.0, 115.0, 114.0, 113.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 95.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 49.0, 49.0, 48.0, 50.0, 49.0, 52.0, 48.0, 48.0, 48.0], "value": 48.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 59.0, 60.0, 54.0, 54.0, 54.0, 54.0, 58.0, 58.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 72.0, 72.0, 77.0, 73.0, 71.0, 72.0, 72.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 112.0, 119.0, 120.0, 109.0, 113.0, 113.0, 117.0, 114.0, 158.0], "value": 119.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 167.0, 175.0, 171.0, 166.0, 176.0, 159.0, 160.0, 173.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 66.0, 67.0, 61.0, 59.0, 59.0, 62.0, 59.0, 61.0], "value": 61.6, "unit": "score"}]}]} 06:18:12 INFO - Return code: 0 06:18:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:18:12 INFO - # TBPL SUCCESS # 06:18:12 INFO - Running post-action listener: _package_coverage_data 06:18:12 INFO - Running post-action listener: _resource_record_post_action 06:18:12 INFO - [mozharness: 2017-08-21 13:18:12.187141Z] Finished run-tests step (success) 06:18:12 INFO - Running post-run listener: _resource_record_post_run 06:18:12 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 423432192; Read time: 0; Write time: 603024 06:18:12 INFO - TinderboxPrint: CPU usage
13.1% 06:18:12 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:18:12 INFO - TinderboxPrint: I/O write bytes / time
423,432,192 / 603,024 06:18:12 INFO - TinderboxPrint: CPU idle
8,246.3 (86.9%) 06:18:12 INFO - TinderboxPrint: CPU user
1,188.3 (12.5%) 06:18:12 INFO - TinderboxPrint: Swap in / out
0 / 0 06:18:12 INFO - install - Wall time: 20s; CPU: 13.0%; Read bytes: 0; Write bytes: 107880448; Read time: 0; Write time: 188972 06:18:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:18:12 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 312360960; Read time: 0; Write time: 413568 06:18:12 INFO - Running post-run listener: _upload_blobber_files 06:18:12 INFO - Blob upload gear active. 06:18:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:18:13 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:18:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:18:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:14 INFO - (blobuploader) - INFO - Done attempting. 06:18:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:18:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:18:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:17 INFO - (blobuploader) - INFO - Done attempting. 06:18:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:18:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:18:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:17 INFO - (blobuploader) - INFO - Done attempting. 06:18:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:18:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:18:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:18 INFO - (blobuploader) - INFO - Done attempting. 06:18:18 INFO - (blobuploader) - INFO - Iteration through files over. 06:18:18 INFO - Return code: 0 06:18:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:18:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:18:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c814e5973e029fc1581b5ce43a88bafde86914cc3fb1b2b254b028157cb9524a0e89be9abc5c226fa4f7f1bdb3670cb65d0ac60449924c4ff3a68ba45046cff7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3da7dac0a93f439420cc35d59c986cbf4b71342c29e24ce1d93423294a5d06c4373173e3abe03cd6432c1f56ea2361ecd2269f869734883a1c425f6bd6becc81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ec859aac09989635af2372a1631b954dbe5ca19445196d9b7be947151eb7c839f692c3e51c27d53d8d28f08755b5866fea50b554afec3f071c899dff5001150", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01121e020e69b278a41606f2d34fcc3b169182d683f8396b47e09452a7af6084dc40538049b0b8e8a49f56aa7d5681b106be1ef507472fe10b11cace16dc7ce8"} 06:18:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:18:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:18:18 INFO - Contents: 06:18:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c814e5973e029fc1581b5ce43a88bafde86914cc3fb1b2b254b028157cb9524a0e89be9abc5c226fa4f7f1bdb3670cb65d0ac60449924c4ff3a68ba45046cff7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3da7dac0a93f439420cc35d59c986cbf4b71342c29e24ce1d93423294a5d06c4373173e3abe03cd6432c1f56ea2361ecd2269f869734883a1c425f6bd6becc81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ec859aac09989635af2372a1631b954dbe5ca19445196d9b7be947151eb7c839f692c3e51c27d53d8d28f08755b5866fea50b554afec3f071c899dff5001150", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01121e020e69b278a41606f2d34fcc3b169182d683f8396b47e09452a7af6084dc40538049b0b8e8a49f56aa7d5681b106be1ef507472fe10b11cace16dc7ce8"} 06:18:18 INFO - Running post-run listener: copy_logs_to_upload_dir 06:18:18 INFO - Copying logs to upload dir... 06:18:18 INFO - mkdir: /builds/slave/test/build/upload/logs 06:18:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.614902 ========= master_lag: -0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-21 06:18:18.763340) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 06:18:18.766520) ========= 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=8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c814e5973e029fc1581b5ce43a88bafde86914cc3fb1b2b254b028157cb9524a0e89be9abc5c226fa4f7f1bdb3670cb65d0ac60449924c4ff3a68ba45046cff7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3da7dac0a93f439420cc35d59c986cbf4b71342c29e24ce1d93423294a5d06c4373173e3abe03cd6432c1f56ea2361ecd2269f869734883a1c425f6bd6becc81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ec859aac09989635af2372a1631b954dbe5ca19445196d9b7be947151eb7c839f692c3e51c27d53d8d28f08755b5866fea50b554afec3f071c899dff5001150", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01121e020e69b278a41606f2d34fcc3b169182d683f8396b47e09452a7af6084dc40538049b0b8e8a49f56aa7d5681b106be1ef507472fe10b11cace16dc7ce8"} build_url:https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011365 build_url: 'https://queue.taskcluster.net/v1/task/VoBTrwLDQM-CaEcOvQaXfQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c814e5973e029fc1581b5ce43a88bafde86914cc3fb1b2b254b028157cb9524a0e89be9abc5c226fa4f7f1bdb3670cb65d0ac60449924c4ff3a68ba45046cff7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3da7dac0a93f439420cc35d59c986cbf4b71342c29e24ce1d93423294a5d06c4373173e3abe03cd6432c1f56ea2361ecd2269f869734883a1c425f6bd6becc81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ec859aac09989635af2372a1631b954dbe5ca19445196d9b7be947151eb7c839f692c3e51c27d53d8d28f08755b5866fea50b554afec3f071c899dff5001150", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01121e020e69b278a41606f2d34fcc3b169182d683f8396b47e09452a7af6084dc40538049b0b8e8a49f56aa7d5681b106be1ef507472fe10b11cace16dc7ce8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 06:18:18.796076) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 06:18:18.796480) ========= 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=8783db0840cc980e80bb0bd400000236-1503320248.305759-1299275667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004357 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 06:18:18.905402) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 06:18:18.905754) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 06:18:18.909547) ========= ========= Total master_lag: 0.03 =========