builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1503503160.08 results: success (0) revision: 446cd9f4b0f5684adaf275a999e0361988a95cfe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 08:46:00.077189) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 08:46:00.077649) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 08:46:00.077945) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 08:46:00.092816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:46:00.093191) ========= 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=eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 08:46:00-- 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% 19.8M=0.001s 2017-08-23 08:46:00 (19.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129484 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:46:00.234370) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:46:00.234677) ========= 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=eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019486 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:46:00.287677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-23 08:46:00.291104) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 446cd9f4b0f5684adaf275a999e0361988a95cfe --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 446cd9f4b0f5684adaf275a999e0361988a95cfe --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=eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 08:46:00,862 truncating revision to first 12 chars 2017-08-23 08:46:00,862 Setting DEBUG logging. 2017-08-23 08:46:00,862 attempt 1/10 2017-08-23 08:46:00,862 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/446cd9f4b0f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-23 08:46:01,668 unpacking tar archive at: mozilla-central-446cd9f4b0f5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.129237 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-23 08:46:01.435267) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 08:46:01.435581) ========= script_repo_revision: 446cd9f4b0f5684adaf275a999e0361988a95cfe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 08:46:01.438977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 08:46:01.439238) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 08:46:01.450793) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-23 08:46:01.451159) ========= /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=eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:46:02 INFO - MultiFileLogger online at 20170823 08:46:02 in /builds/slave/test 08:46:02 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 08:46:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:46:02 INFO - {'append_to_log': False, 08:46:02 INFO - 'base_work_dir': '/builds/slave/test', 08:46:02 INFO - 'blob_upload_branch': 'Firefox', 08:46:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:46:02 INFO - 'branch': 'Firefox', 08:46:02 INFO - 'buildbot_json_path': 'buildprops.json', 08:46:02 INFO - 'code_coverage': False, 08:46:02 INFO - 'config_files': ('talos/linux_config.py',), 08:46:02 INFO - 'default_actions': ('clobber', 08:46:02 INFO - 'read-buildbot-config', 08:46:02 INFO - 'download-and-extract', 08:46:02 INFO - 'populate-webroot', 08:46:02 INFO - 'create-virtualenv', 08:46:02 INFO - 'install', 08:46:02 INFO - 'setup-mitmproxy', 08:46:02 INFO - 'run-tests'), 08:46:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:46:02 INFO - 'disable_ccov_upload': False, 08:46:02 INFO - 'download_minidump_stackwalk': True, 08:46:02 INFO - 'download_symbols': 'ondemand', 08:46:02 INFO - 'enable_stylo': False, 08:46:02 INFO - 'enable_webrender': False, 08:46:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:46:02 INFO - 'tooltool.py': '/tools/tooltool.py', 08:46:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:46:02 INFO - '/tools/misc-python/virtualenv.py')}, 08:46:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:46:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:46:02 INFO - 'gecko_profile': False, 08:46:02 INFO - 'gecko_profile_interval': 0, 08:46:02 INFO - 'installer_path': 'installer.exe', 08:46:02 INFO - 'log_level': 'info', 08:46:02 INFO - 'log_name': 'talos', 08:46:02 INFO - 'log_to_console': True, 08:46:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:46:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:46:02 INFO - 'opt_config_files': (), 08:46:02 INFO - 'pip_index': False, 08:46:02 INFO - 'suite': 'dromaeojs-e10s', 08:46:02 INFO - 'system_bits': '32', 08:46:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:46:02 INFO - 'title': 'talos-linux64-ix-010', 08:46:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:46:02 INFO - 'use_talos_json': True, 08:46:02 INFO - 'verify': 'False', 08:46:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:46:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:46:02 INFO - 'work_dir': 'build'} 08:46:02 INFO - [mozharness: 2017-08-23 15:46:02.171514Z] Running clobber step. 08:46:02 INFO - Running pre-action listener: _resource_record_pre_action 08:46:02 INFO - Running main action method: clobber 08:46:02 INFO - rmtree: /builds/slave/test/build 08:46:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:46:03 INFO - Running post-action listener: _resource_record_post_action 08:46:03 INFO - [mozharness: 2017-08-23 15:46:03.307826Z] Finished clobber step (success) 08:46:03 INFO - [mozharness: 2017-08-23 15:46:03.307924Z] Running read-buildbot-config step. 08:46:03 INFO - Running pre-action listener: _resource_record_pre_action 08:46:03 INFO - Running main action method: read_buildbot_config 08:46:03 INFO - Using buildbot properties: 08:46:03 INFO - { 08:46:03 INFO - "project": "", 08:46:03 INFO - "product": "firefox", 08:46:03 INFO - "who": "archaeopteryx@coole-files.de", 08:46:03 INFO - "installer_path": "public/build/target.tar.bz2", 08:46:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:46:03 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 08:46:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 08:46:03 INFO - "stage_platform": "linux64-pgo", 08:46:03 INFO - "basedir": "/builds/slave/test", 08:46:03 INFO - "buildnumber": 124, 08:46:03 INFO - "platform": "ubuntu64_hw", 08:46:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:46:03 INFO - "slavebuilddir": "test", 08:46:03 INFO - "taskId": "AW_jbabATO2PwKsI3yypZA", 08:46:03 INFO - "branch": "mozilla-central", 08:46:03 INFO - "script_repo_revision": "production", 08:46:03 INFO - "revision": "446cd9f4b0f5684adaf275a999e0361988a95cfe", 08:46:03 INFO - "slavename": "talos-linux64-ix-010", 08:46:03 INFO - "repo_path": "mozilla-central" 08:46:03 INFO - } 08:46:03 INFO - Finding installer, test and symbols from parent task. 08:46:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AW_jbabATO2PwKsI3yypZA'}, attempt #1 08:46:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AW_jbabATO2PwKsI3yypZA'}, attempt #1 08:46:04 INFO - Task dependencies: DHoxQ2R4S7S_LLlUuf292w 08:46:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w'}, attempt #1 08:46:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.tar.bz2 08:46:04 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.test_packages.json 08:46:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.crashreporter-symbols.zip 08:46:04 INFO - Running post-action listener: _resource_record_post_action 08:46:04 INFO - [mozharness: 2017-08-23 15:46:04.856843Z] Finished read-buildbot-config step (success) 08:46:04 INFO - [mozharness: 2017-08-23 15:46:04.857018Z] Running download-and-extract step. 08:46:04 INFO - Running pre-action listener: _resource_record_pre_action 08:46:04 INFO - Running main action method: download_and_extract 08:46:04 INFO - mkdir: /builds/slave/test/build/tests 08:46: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')]} 08:46:04 INFO - trying https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.test_packages.json 08:46:04 INFO - Downloading https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:46:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:46:05 INFO - Downloaded 989 bytes. 08:46:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:46:05 INFO - Using the following test package requirements: 08:46:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:46:05 INFO - u'common': [u'target.common.tests.zip'], 08:46:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:46:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:46:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:46:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:46:05 INFO - u'mozbase': [u'target.common.tests.zip'], 08:46:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:46:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:46:05 INFO - u'web-platform': [u'target.common.tests.zip', 08:46:05 INFO - u'target.web-platform.tests.tar.gz'], 08:46:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:46:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:46:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.common.tests.zip 08:46:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:46:05 INFO - Fetch https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.common.tests.zip into memory 08:46:06 INFO - Content-Length response header: 55741654 08:46:06 INFO - Bytes received: 55741654 08:46:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:46:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.common.tests.zip 08:46:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:46:17 INFO - Fetch https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.common.tests.zip into memory 08:46:18 INFO - Content-Length response header: 55741654 08:46:18 INFO - Bytes received: 55741654 08:46:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.talos.tests.zip 08:46:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:46:30 INFO - Fetch https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.talos.tests.zip into memory 08:46:31 INFO - Content-Length response header: 14496261 08:46:31 INFO - Bytes received: 14496261 08:46:31 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')]} 08:46:31 INFO - trying https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.tar.bz2 08:46:31 INFO - Downloading https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:46:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:46:32 INFO - Downloaded 62228403 bytes. 08:46:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.tar.bz2 08:46:32 INFO - mkdir: /builds/slave/test/properties 08:46:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:46:32 INFO - Writing to file /builds/slave/test/properties/build_url 08:46:32 INFO - Contents: 08:46:32 INFO - build_url:https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.tar.bz2 08:46:32 INFO - Running post-action listener: _resource_record_post_action 08:46:32 INFO - Running post-action listener: find_tests_for_verification 08:46:32 INFO - Running post-action listener: set_extra_try_arguments 08:46:32 INFO - [mozharness: 2017-08-23 15:46:32.870822Z] Finished download-and-extract step (success) 08:46:32 INFO - [mozharness: 2017-08-23 15:46:32.870919Z] Running populate-webroot step. 08:46:32 INFO - Running pre-action listener: _resource_record_pre_action 08:46:32 INFO - Running main action method: populate_webroot 08:46:32 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:46:32 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 08:46:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:46:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:46:32 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 08:46:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:46:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:46:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:32 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:46:32 INFO - 'talos_options': ['--stylo'], 08:46:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:46:32 INFO - 'tests': ['damp', 'tps']}, 08:46:32 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:46:32 INFO - 'talos_options': ['--stylo'], 08:46:32 INFO - 'tests': ['damp', 'tps']}, 08:46:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:46:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:46:32 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 08:46:32 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:46:32 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:46:32 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:46:32 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:46:32 INFO - 'talos_options': ['--stylo'], 08:46:32 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:46:32 INFO - 'other-e10s': {'tests': ['a11yr', 08:46:32 INFO - 'ts_paint', 08:46:32 INFO - 'tpaint', 08:46:32 INFO - 'sessionrestore', 08:46:32 INFO - 'sessionrestore_many_windows', 08:46:32 INFO - 'sessionrestore_no_auto_restore', 08:46:32 INFO - 'tabpaint']}, 08:46:32 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 08:46:32 INFO - 'tests': ['a11yr', 08:46:32 INFO - 'ts_paint', 08:46:32 INFO - 'tpaint', 08:46:32 INFO - 'sessionrestore', 08:46:32 INFO - 'sessionrestore_many_windows', 08:46:32 INFO - 'sessionrestore_no_auto_restore', 08:46:32 INFO - 'tabpaint']}, 08:46:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:46:32 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:46:32 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 08:46:32 INFO - 'tests': ['bloom_basic_singleton']}, 08:46:32 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 08:46:32 INFO - 'tests': ['bloom_basic']}, 08:46:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:46:32 INFO - 'tsvgr_opacity', 08:46:32 INFO - 'tart', 08:46:32 INFO - 'tscrollx', 08:46:32 INFO - 'tsvg_static']}, 08:46:32 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 08:46:32 INFO - 'tests': ['tsvgx', 08:46:32 INFO - 'tsvgr_opacity', 08:46:32 INFO - 'tart', 08:46:32 INFO - 'tscrollx', 08:46:32 INFO - 'tsvg_static']}, 08:46:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:46:32 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:46:32 INFO - 'talos_options': ['--stylo'], 08:46:32 INFO - 'tests': ['tp5o']}, 08:46:32 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:46:32 INFO - 'talos_options': ['--mitmproxy', 08:46:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:46:32 INFO - '--firstNonBlankPaint'], 08:46:32 INFO - 'tests': ['tp6_google', 08:46:32 INFO - 'tp6_youtube', 08:46:32 INFO - 'tp6_amazon', 08:46:32 INFO - 'tp6_facebook']}, 08:46:32 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:46:32 INFO - 'talos_options': ['--stylo', 08:46:32 INFO - '--mitmproxy', 08:46:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:46:32 INFO - '--firstNonBlankPaint'], 08:46:32 INFO - 'tests': ['tp6_google', 08:46:32 INFO - 'tp6_youtube', 08:46:32 INFO - 'tp6_amazon', 08:46:32 INFO - 'tp6_facebook']}, 08:46:32 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:46:32 INFO - 'talos_options': ['--stylo', 08:46:32 INFO - '--stylo-threads=1', 08:46:32 INFO - '--mitmproxy', 08:46:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:46:32 INFO - '--firstNonBlankPaint'], 08:46:32 INFO - 'tests': ['tp6_google', 08:46:32 INFO - 'tp6_youtube', 08:46:32 INFO - 'tp6_amazon', 08:46:32 INFO - 'tp6_facebook']}, 08:46:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:46:32 INFO - 'talos_options': ['--xperf_path', 08:46:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:32 INFO - 'tests': ['tp5n']}, 08:46:32 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:46:32 INFO - 'talos_options': ['--stylo', 08:46:32 INFO - '--xperf_path', 08:46:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:32 INFO - 'tests': ['tp5n']}}} 08:46:32 INFO - Running post-action listener: _resource_record_post_action 08:46:32 INFO - [mozharness: 2017-08-23 15:46:32.885135Z] Finished populate-webroot step (success) 08:46:32 INFO - [mozharness: 2017-08-23 15:46:32.885227Z] Running create-virtualenv step. 08:46:32 INFO - Running pre-action listener: _resource_record_pre_action 08:46:32 INFO - Running main action method: create_virtualenv 08:46:32 INFO - Creating virtualenv /builds/slave/test/build/venv 08:46:32 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 08:46:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:46:32 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:46:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:46:32 INFO - Using real prefix '/usr' 08:46:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:46:33 INFO - Installing distribute.............................................................................................................................................................................................done. 08:46:35 INFO - Installing pip.................done. 08:46:35 INFO - Return code: 0 08:46:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:46:35 INFO - Reading from file tmpfile_stdout 08:46:35 INFO - Output received: 08:46:35 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) 08:46:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:35 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 0x21cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2398a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2539130>, '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 0x253a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253a4c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', '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 08:46:35 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 08:46:35 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 08:46:35 INFO - Using env: {'DISPLAY': ':0', 08:46:35 INFO - 'HOME': '/home/cltbld', 08:46:35 INFO - 'LANG': 'en_US.UTF-8', 08:46:35 INFO - 'LANGUAGE': 'en_US:en', 08:46:35 INFO - 'LOGNAME': 'cltbld', 08:46:35 INFO - 'MAIL': '/var/mail/cltbld', 08:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:35 INFO - 'MOZ_NO_REMOTE': '1', 08:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:35 INFO - 'NO_EM_RESTART': '1', 08:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:35 INFO - 'PWD': '/builds/slave/test', 08:46:35 INFO - 'SHELL': '/bin/bash', 08:46:35 INFO - 'SHLVL': '1', 08:46:35 INFO - 'TERM': 'linux', 08:46:35 INFO - 'TMOUT': '86400', 08:46:35 INFO - 'USER': 'cltbld', 08:46:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', 08:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:35 INFO - '_': '/tools/buildbot/bin/python'} 08:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:35 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 08:46:35 INFO - Cleaning up... 08:46:35 INFO - Return code: 0 08:46:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:35 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 0x21cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2398a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2539130>, '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 0x253a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253a4c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', '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 08:46:35 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 08:46:35 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 08:46:35 INFO - Using env: {'DISPLAY': ':0', 08:46:35 INFO - 'HOME': '/home/cltbld', 08:46:35 INFO - 'LANG': 'en_US.UTF-8', 08:46:35 INFO - 'LANGUAGE': 'en_US:en', 08:46:35 INFO - 'LOGNAME': 'cltbld', 08:46:35 INFO - 'MAIL': '/var/mail/cltbld', 08:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:35 INFO - 'MOZ_NO_REMOTE': '1', 08:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:35 INFO - 'NO_EM_RESTART': '1', 08:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:35 INFO - 'PWD': '/builds/slave/test', 08:46:35 INFO - 'SHELL': '/bin/bash', 08:46:35 INFO - 'SHLVL': '1', 08:46:35 INFO - 'TERM': 'linux', 08:46:35 INFO - 'TMOUT': '86400', 08:46:35 INFO - 'USER': 'cltbld', 08:46:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', 08:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:35 INFO - '_': '/tools/buildbot/bin/python'} 08:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:36 INFO - Downloading/unpacking psutil>=3.1.1 08:46:36 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 08:46:36 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 08:46:36 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 08:46:36 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 08:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:46:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:37 INFO - Installing collected packages: psutil 08:46:37 INFO - Running setup.py install for psutil 08:46:37 INFO - building 'psutil._psutil_linux' extension 08:46:37 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 08:46:37 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 08:46:37 INFO - building 'psutil._psutil_posix' extension 08:46:37 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 08:46:37 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 08:46:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:37 INFO - Successfully installed psutil 08:46:37 INFO - Cleaning up... 08:46:37 INFO - Return code: 0 08:46:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:46:37 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')]} 08:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:37 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')]} 08:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:37 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 0x21cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2398a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2539130>, '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 0x253a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253a4c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', '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 08:46:37 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 08:46:37 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 08:46:37 INFO - Using env: {'DISPLAY': ':0', 08:46:37 INFO - 'HOME': '/home/cltbld', 08:46:37 INFO - 'LANG': 'en_US.UTF-8', 08:46:37 INFO - 'LANGUAGE': 'en_US:en', 08:46:37 INFO - 'LOGNAME': 'cltbld', 08:46:37 INFO - 'MAIL': '/var/mail/cltbld', 08:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:37 INFO - 'MOZ_NO_REMOTE': '1', 08:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:37 INFO - 'NO_EM_RESTART': '1', 08:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:37 INFO - 'PWD': '/builds/slave/test', 08:46:37 INFO - 'SHELL': '/bin/bash', 08:46:37 INFO - 'SHLVL': '1', 08:46:37 INFO - 'TERM': 'linux', 08:46:37 INFO - 'TMOUT': '86400', 08:46:37 INFO - 'USER': 'cltbld', 08:46:37 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', 08:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:37 INFO - '_': '/tools/buildbot/bin/python'} 08:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:46:38 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 08:46:38 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 08:46:38 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 08:46:38 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 08:46:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:46:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:46:39 INFO - Installing collected packages: mozsystemmonitor 08:46:39 INFO - Running setup.py install for mozsystemmonitor 08:46:39 INFO - Successfully installed mozsystemmonitor 08:46:39 INFO - Cleaning up... 08:46:39 INFO - Return code: 0 08:46:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:39 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 0x21cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2398a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2539130>, '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 0x253a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253a4c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', '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 08:46:39 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 08:46:39 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 08:46:39 INFO - Using env: {'DISPLAY': ':0', 08:46:39 INFO - 'HOME': '/home/cltbld', 08:46:39 INFO - 'LANG': 'en_US.UTF-8', 08:46:39 INFO - 'LANGUAGE': 'en_US:en', 08:46:39 INFO - 'LOGNAME': 'cltbld', 08:46:39 INFO - 'MAIL': '/var/mail/cltbld', 08:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:39 INFO - 'MOZ_NO_REMOTE': '1', 08:46:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:39 INFO - 'NO_EM_RESTART': '1', 08:46:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:39 INFO - 'PWD': '/builds/slave/test', 08:46:39 INFO - 'SHELL': '/bin/bash', 08:46:39 INFO - 'SHLVL': '1', 08:46:39 INFO - 'TERM': 'linux', 08:46:39 INFO - 'TMOUT': '86400', 08:46:39 INFO - 'USER': 'cltbld', 08:46:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', 08:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:39 INFO - '_': '/tools/buildbot/bin/python'} 08:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:39 INFO - Downloading/unpacking jsonschema==2.5.1 08:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:46:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:40 INFO - Downloading functools32-3.2.3-2.tar.gz 08:46:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:46:40 INFO - warning: no files found matching '*.txt' 08:46:40 INFO - no previously-included directories found matching 'build' 08:46:40 INFO - no previously-included directories found matching 'dist' 08:46:40 INFO - no previously-included directories found matching '.git*' 08:46:40 INFO - Installing collected packages: jsonschema, functools32 08:46:40 INFO - Running setup.py install for functools32 08:46:41 INFO - warning: no files found matching '*.txt' 08:46:41 INFO - no previously-included directories found matching 'build' 08:46:41 INFO - no previously-included directories found matching 'dist' 08:46:41 INFO - no previously-included directories found matching '.git*' 08:46:41 INFO - Successfully installed jsonschema functools32 08:46:41 INFO - Cleaning up... 08:46:41 INFO - Return code: 0 08:46:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46: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')]} 08:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:41 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 0x21cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2398a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2539130>, '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 0x253a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253a4c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', '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 08:46:41 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 08:46:41 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 08:46:41 INFO - Using env: {'DISPLAY': ':0', 08:46:41 INFO - 'HOME': '/home/cltbld', 08:46:41 INFO - 'LANG': 'en_US.UTF-8', 08:46:41 INFO - 'LANGUAGE': 'en_US:en', 08:46:41 INFO - 'LOGNAME': 'cltbld', 08:46:41 INFO - 'MAIL': '/var/mail/cltbld', 08:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:41 INFO - 'MOZ_NO_REMOTE': '1', 08:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:41 INFO - 'NO_EM_RESTART': '1', 08:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:41 INFO - 'PWD': '/builds/slave/test', 08:46:41 INFO - 'SHELL': '/bin/bash', 08:46:41 INFO - 'SHLVL': '1', 08:46:41 INFO - 'TERM': 'linux', 08:46:41 INFO - 'TMOUT': '86400', 08:46:41 INFO - 'USER': 'cltbld', 08:46:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', 08:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:41 INFO - '_': '/tools/buildbot/bin/python'} 08:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:46:41 INFO - Cleaning up... 08:46:41 INFO - Return code: 0 08:46:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46: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')]} 08:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:41 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 0x21cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2398a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2539130>, '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 0x253a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253a4c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', '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 08:46:41 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 08:46:41 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 08:46:41 INFO - Using env: {'DISPLAY': ':0', 08:46:41 INFO - 'HOME': '/home/cltbld', 08:46:41 INFO - 'LANG': 'en_US.UTF-8', 08:46:41 INFO - 'LANGUAGE': 'en_US:en', 08:46:41 INFO - 'LOGNAME': 'cltbld', 08:46:41 INFO - 'MAIL': '/var/mail/cltbld', 08:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:41 INFO - 'MOZ_NO_REMOTE': '1', 08:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:41 INFO - 'NO_EM_RESTART': '1', 08:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:41 INFO - 'PWD': '/builds/slave/test', 08:46:41 INFO - 'SHELL': '/bin/bash', 08:46:41 INFO - 'SHLVL': '1', 08:46:41 INFO - 'TERM': 'linux', 08:46:41 INFO - 'TMOUT': '86400', 08:46:41 INFO - 'USER': 'cltbld', 08:46:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', 08:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:41 INFO - '_': '/tools/buildbot/bin/python'} 08:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:41 INFO - Downloading/unpacking blobuploader==1.2.4 08:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:42 INFO - Downloading blobuploader-1.2.4.tar.gz 08:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:46:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:46:42 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 08:46:42 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 08:46:42 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 08:46:42 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 08:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:46:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:46:43 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 08:46:43 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 08:46:43 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 08:46:43 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 08:46:43 INFO - Downloading docopt-0.6.1.tar.gz 08:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:46:43 INFO - Installing collected packages: blobuploader, requests, docopt 08:46:43 INFO - Running setup.py install for blobuploader 08:46:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:46:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:46:43 INFO - Running setup.py install for requests 08:46:43 INFO - Running setup.py install for docopt 08:46:43 INFO - Successfully installed blobuploader requests docopt 08:46:43 INFO - Cleaning up... 08:46:43 INFO - Return code: 0 08:46:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:43 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 0x21cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2398a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2539130>, '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 0x253a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253a4c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', '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 08:46:43 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 08:46:43 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 08:46:43 INFO - Using env: {'DISPLAY': ':0', 08:46:43 INFO - 'HOME': '/home/cltbld', 08:46:43 INFO - 'LANG': 'en_US.UTF-8', 08:46:43 INFO - 'LANGUAGE': 'en_US:en', 08:46:43 INFO - 'LOGNAME': 'cltbld', 08:46:43 INFO - 'MAIL': '/var/mail/cltbld', 08:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:43 INFO - 'MOZ_NO_REMOTE': '1', 08:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:43 INFO - 'NO_EM_RESTART': '1', 08:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:43 INFO - 'PWD': '/builds/slave/test', 08:46:43 INFO - 'SHELL': '/bin/bash', 08:46:43 INFO - 'SHLVL': '1', 08:46:43 INFO - 'TERM': 'linux', 08:46:43 INFO - 'TMOUT': '86400', 08:46:43 INFO - 'USER': 'cltbld', 08:46:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', 08:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:43 INFO - '_': '/tools/buildbot/bin/python'} 08:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:44 INFO - Running setup.py (path:/tmp/pip-igsfpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:44 INFO - Running setup.py (path:/tmp/pip-BIMNRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:44 INFO - Running setup.py (path:/tmp/pip-RUWNqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:44 INFO - Running setup.py (path:/tmp/pip-6eJEZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:44 INFO - Running setup.py (path:/tmp/pip-uZcBB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:44 INFO - Running setup.py (path:/tmp/pip-7xgGFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:44 INFO - Running setup.py (path:/tmp/pip-n95euJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:44 INFO - Running setup.py (path:/tmp/pip-hSD93z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:44 INFO - Running setup.py (path:/tmp/pip-vtzoXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:44 INFO - Running setup.py (path:/tmp/pip-HOO5_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:44 INFO - Running setup.py (path:/tmp/pip-LysyUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:44 INFO - Running setup.py (path:/tmp/pip-WCF6FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:44 INFO - Running setup.py (path:/tmp/pip-R_pHhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:45 INFO - Running setup.py (path:/tmp/pip-LhH3rR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:45 INFO - Running setup.py (path:/tmp/pip-0803cW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:45 INFO - Running setup.py (path:/tmp/pip-FPyZ9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:45 INFO - Running setup.py (path:/tmp/pip-RGfZdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:46:45 INFO - Running setup.py install for manifestparser 08:46:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:46:45 INFO - Running setup.py install for mozcrash 08:46:45 INFO - Running setup.py install for mozdebug 08:46:45 INFO - Running setup.py install for mozdevice 08:46:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:46:45 INFO - Running setup.py install for mozfile 08:46:45 INFO - Running setup.py install for mozhttpd 08:46:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:46:45 INFO - Running setup.py install for mozinfo 08:46:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:46:46 INFO - Running setup.py install for mozInstall 08:46:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:46:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:46:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:46:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:46:46 INFO - Running setup.py install for mozleak 08:46:46 INFO - Running setup.py install for mozlog 08:46:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:46:46 INFO - Running setup.py install for moznetwork 08:46:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:46:46 INFO - Running setup.py install for mozprocess 08:46:46 INFO - Running setup.py install for mozprofile 08:46:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:46:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:46:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:46:46 INFO - Running setup.py install for mozrunner 08:46:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:46:46 INFO - Running setup.py install for mozscreenshot 08:46:46 INFO - Running setup.py install for moztest 08:46:46 INFO - Running setup.py install for mozversion 08:46:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:46:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:46:47 INFO - Cleaning up... 08:46:47 INFO - Return code: 0 08:46:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:47 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')]} 08:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:47 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')]} 08:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:47 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 0x21cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2398a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2539130>, '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 0x253a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253a4c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', '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 08:46:47 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 08:46:47 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 08:46:47 INFO - Using env: {'DISPLAY': ':0', 08:46:47 INFO - 'HOME': '/home/cltbld', 08:46:47 INFO - 'LANG': 'en_US.UTF-8', 08:46:47 INFO - 'LANGUAGE': 'en_US:en', 08:46:47 INFO - 'LOGNAME': 'cltbld', 08:46:47 INFO - 'MAIL': '/var/mail/cltbld', 08:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:47 INFO - 'MOZ_NO_REMOTE': '1', 08:46:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:47 INFO - 'NO_EM_RESTART': '1', 08:46:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:47 INFO - 'PWD': '/builds/slave/test', 08:46:47 INFO - 'SHELL': '/bin/bash', 08:46:47 INFO - 'SHLVL': '1', 08:46:47 INFO - 'TERM': 'linux', 08:46:47 INFO - 'TMOUT': '86400', 08:46:47 INFO - 'USER': 'cltbld', 08:46:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', 08:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:47 INFO - '_': '/tools/buildbot/bin/python'} 08:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:47 INFO - Running setup.py (path:/tmp/pip-n14ckQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:47 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)) 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:47 INFO - Running setup.py (path:/tmp/pip-_jAmAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:47 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)) 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:47 INFO - Running setup.py (path:/tmp/pip-OmuDPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:47 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)) 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:47 INFO - Running setup.py (path:/tmp/pip-nby4en-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:47 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)) 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:47 INFO - Running setup.py (path:/tmp/pip-vDR1un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:47 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)) 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:47 INFO - Running setup.py (path:/tmp/pip-b4dnqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:47 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)) 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:47 INFO - Running setup.py (path:/tmp/pip-wSo6sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:47 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)) 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:47 INFO - Running setup.py (path:/tmp/pip-YhoC3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:47 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)) 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:47 INFO - Running setup.py (path:/tmp/pip-lnktAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:47 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)) 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:47 INFO - Running setup.py (path:/tmp/pip-jUz09n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:48 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)) 08:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:48 INFO - Running setup.py (path:/tmp/pip-pS53VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:48 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)) 08:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:48 INFO - Running setup.py (path:/tmp/pip-Kx0w5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:48 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)) 08:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:48 INFO - Running setup.py (path:/tmp/pip-Lru9db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:48 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)) 08:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:48 INFO - Running setup.py (path:/tmp/pip-8NofJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:48 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)) 08:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:48 INFO - Running setup.py (path:/tmp/pip-E8oDwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:48 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)) 08:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:48 INFO - Running setup.py (path:/tmp/pip-TCjFzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:48 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)) 08:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:48 INFO - Running setup.py (path:/tmp/pip-uX3p9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:48 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)) 08:46:48 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)) 08:46:48 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)) 08:46:48 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)) 08:46:48 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)) 08:46:48 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)) 08:46:48 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)) 08:46:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:46:48 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 08:46:48 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 08:46:48 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 08:46:48 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 08:46:49 INFO - Downloading blessings-1.6.tar.gz 08:46:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:46:49 INFO - Installing collected packages: blessings 08:46:49 INFO - Running setup.py install for blessings 08:46:49 INFO - Successfully installed blessings 08:46:49 INFO - Cleaning up... 08:46:49 INFO - Return code: 0 08:46:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:46:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:50 INFO - Reading from file tmpfile_stdout 08:46:50 INFO - Current package versions: 08:46:50 INFO - argparse == 1.2.1 08:46:50 INFO - blessings == 1.6 08:46:50 INFO - blobuploader == 1.2.4 08:46:50 INFO - docopt == 0.6.1 08:46:50 INFO - functools32 == 3.2.3-2 08:46:50 INFO - jsonschema == 2.5.1 08:46:50 INFO - manifestparser == 1.1 08:46:50 INFO - mozInstall == 1.13 08:46:50 INFO - mozcrash == 1.0 08:46:50 INFO - mozdebug == 0.1 08:46:50 INFO - mozdevice == 0.51 08:46:50 INFO - mozfile == 1.2 08:46:50 INFO - mozhttpd == 0.7 08:46:50 INFO - mozinfo == 0.10 08:46:50 INFO - mozleak == 0.1 08:46:50 INFO - mozlog == 3.5 08:46:50 INFO - moznetwork == 0.27 08:46:50 INFO - mozprocess == 0.25 08:46:50 INFO - mozprofile == 0.28 08:46:50 INFO - mozrunner == 6.13 08:46:50 INFO - mozscreenshot == 0.1 08:46:50 INFO - mozsystemmonitor == 0.3 08:46:50 INFO - moztest == 0.8 08:46:50 INFO - mozversion == 1.4 08:46:50 INFO - psutil == 3.1.1 08:46:50 INFO - requests == 1.2.3 08:46:50 INFO - wsgiref == 0.1.2 08:46:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:50 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')]} 08:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:50 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')]} 08:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:50 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 0x21cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2398a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2539130>, '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 0x253a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253a4c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', '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 08:46:50 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 08:46:50 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 08:46:50 INFO - Using env: {'DISPLAY': ':0', 08:46:50 INFO - 'HOME': '/home/cltbld', 08:46:50 INFO - 'LANG': 'en_US.UTF-8', 08:46:50 INFO - 'LANGUAGE': 'en_US:en', 08:46:50 INFO - 'LOGNAME': 'cltbld', 08:46:50 INFO - 'MAIL': '/var/mail/cltbld', 08:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:50 INFO - 'MOZ_NO_REMOTE': '1', 08:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:50 INFO - 'NO_EM_RESTART': '1', 08:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:50 INFO - 'PWD': '/builds/slave/test', 08:46:50 INFO - 'SHELL': '/bin/bash', 08:46:50 INFO - 'SHLVL': '1', 08:46:50 INFO - 'TERM': 'linux', 08:46:50 INFO - 'TMOUT': '86400', 08:46:50 INFO - 'USER': 'cltbld', 08:46:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', 08:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:50 INFO - '_': '/tools/buildbot/bin/python'} 08:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:50 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)) 08:46:50 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)) 08:46:50 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)) 08:46:50 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)) 08:46:50 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)) 08:46:50 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)) 08:46:50 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)) 08:46:50 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)) 08:46:50 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)) 08:46:50 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:46:50 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 08:46:50 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 08:46:50 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 08:46:50 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 08:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:46:51 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)) 08:46:51 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)) 08:46:51 INFO - Installing collected packages: simplejson 08:46:51 INFO - Running setup.py install for simplejson 08:46:51 INFO - building 'simplejson._speedups' extension 08:46:51 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 08:46:52 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 08:46:52 INFO - Successfully installed simplejson 08:46:52 INFO - Cleaning up... 08:46:52 INFO - Return code: 0 08:46:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:46:52 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')]} 08:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:52 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')]} 08:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:52 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 0x21cd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2398a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253bf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2539130>, '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 0x253a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253a4c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', '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 08:46:52 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 08:46:52 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 08:46:52 INFO - Using env: {'DISPLAY': ':0', 08:46:52 INFO - 'HOME': '/home/cltbld', 08:46:52 INFO - 'LANG': 'en_US.UTF-8', 08:46:52 INFO - 'LANGUAGE': 'en_US:en', 08:46:52 INFO - 'LOGNAME': 'cltbld', 08:46:52 INFO - 'MAIL': '/var/mail/cltbld', 08:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:52 INFO - 'MOZ_NO_REMOTE': '1', 08:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:52 INFO - 'NO_EM_RESTART': '1', 08:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:52 INFO - 'PWD': '/builds/slave/test', 08:46:52 INFO - 'SHELL': '/bin/bash', 08:46:52 INFO - 'SHLVL': '1', 08:46:52 INFO - 'TERM': 'linux', 08:46:52 INFO - 'TMOUT': '86400', 08:46:52 INFO - 'USER': 'cltbld', 08:46:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', 08:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:52 INFO - '_': '/tools/buildbot/bin/python'} 08:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:46:52 INFO - Cleaning up... 08:46:52 INFO - Return code: 0 08:46:52 INFO - Running post-action listener: _resource_record_post_action 08:46:52 INFO - Running post-action listener: _start_resource_monitoring 08:46:52 INFO - Starting resource monitoring. 08:46:52 INFO - [mozharness: 2017-08-23 15:46:52.814481Z] Finished create-virtualenv step (success) 08:46:52 INFO - [mozharness: 2017-08-23 15:46:52.814992Z] Running install step. 08:46:52 INFO - Running pre-action listener: _resource_record_pre_action 08:46:52 INFO - Running main action method: install 08:46:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:53 INFO - Reading from file tmpfile_stdout 08:46:53 INFO - Detecting whether we're running mozinstall >=1.0... 08:46:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:46:53 INFO - Reading from file tmpfile_stdout 08:46:53 INFO - Output received: 08:46:53 INFO - Usage: mozinstall [options] installer 08:46:53 INFO - Options: 08:46:53 INFO - -h, --help show this help message and exit 08:46:53 INFO - -d DEST, --destination=DEST 08:46:53 INFO - Directory to install application into. [default: 08:46:53 INFO - "/builds/slave/test"] 08:46:53 INFO - --app=APP Application being installed. [default: firefox] 08:46:53 INFO - mkdir: /builds/slave/test/build/application 08:46:53 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'] 08:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:47:10 INFO - Reading from file tmpfile_stdout 08:47:10 INFO - Output received: 08:47:10 INFO - /builds/slave/test/build/application/firefox/firefox 08:47:10 INFO - Running post-action listener: _resource_record_post_action 08:47:10 INFO - [mozharness: 2017-08-23 15:47:10.747907Z] Finished install step (success) 08:47:10 INFO - [mozharness: 2017-08-23 15:47:10.748250Z] Running setup-mitmproxy step. 08:47:10 INFO - Running pre-action listener: _resource_record_pre_action 08:47:10 INFO - Running main action method: setup_mitmproxy 08:47:10 INFO - Skipping: mitmproxy is not required 08:47:10 INFO - Running post-action listener: _resource_record_post_action 08:47:10 INFO - [mozharness: 2017-08-23 15:47:10.749974Z] Finished setup-mitmproxy step (success) 08:47:10 INFO - [mozharness: 2017-08-23 15:47:10.750285Z] Running run-tests step. 08:47:10 INFO - Running pre-action listener: _resource_record_pre_action 08:47:10 INFO - Running pre-action listener: _set_gcov_prefix 08:47:10 INFO - Running main action method: run_tests 08:47:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:47:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:47:10 INFO - Python 2.7.3 08:47:10 INFO - Return code: 0 08:47:10 INFO - grabbing minidump binary from tooltool 08:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:10 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 0x2539130>, '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 0x253a030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253a4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:47:10 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 08:47:10 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 08:47:10 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 08:47:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:47:10 INFO - Return code: 0 08:47:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:47:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:47:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:47:10 INFO - ENV: RUST_BACKTRACE is now full 08:47:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:47:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:47:10 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/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 08:47:10 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/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 08:47:10 INFO - Using env: {'DISPLAY': ':0', 08:47:10 INFO - 'HOME': '/home/cltbld', 08:47:10 INFO - 'LANG': 'en_US.UTF-8', 08:47:10 INFO - 'LANGUAGE': 'en_US:en', 08:47:10 INFO - 'LOGNAME': 'cltbld', 08:47:10 INFO - 'MAIL': '/var/mail/cltbld', 08:47:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:47:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:10 INFO - 'MOZ_NO_REMOTE': '1', 08:47:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:10 INFO - 'NO_EM_RESTART': '1', 08:47:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:10 INFO - 'PWD': '/builds/slave/test', 08:47:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:47:10 INFO - 'RUST_BACKTRACE': 'full', 08:47:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:47:10 INFO - 'SHELL': '/bin/bash', 08:47:10 INFO - 'SHLVL': '1', 08:47:10 INFO - 'TERM': 'linux', 08:47:10 INFO - 'TMOUT': '86400', 08:47:10 INFO - 'USER': 'cltbld', 08:47:10 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762', 08:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:10 INFO - '_': '/tools/buildbot/bin/python'} 08:47:10 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/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 08:47:11 INFO - mozversion application_buildid: 20170823143012 08:47:11 INFO - mozversion application_changeset: 446cd9f4b0f5684adaf275a999e0361988a95cfe 08:47:11 INFO - mozversion application_display_name: Nightly 08:47:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:47:11 INFO - mozversion application_name: Firefox 08:47:11 INFO - mozversion application_remotingname: firefox 08:47:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:47:11 INFO - mozversion application_vendor: Mozilla 08:47:11 INFO - mozversion application_version: 57.0a1 08:47:11 INFO - mozversion platform_buildid: 20170823143012 08:47:11 INFO - mozversion platform_changeset: 446cd9f4b0f5684adaf275a999e0361988a95cfe 08:47:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:47:11 INFO - mozversion platform_version: 57.0a1 08:47:11 INFO - using testdate: 1503503231 08:47:11 INFO - actual date: 1503503231 08:47:11 INFO - starting webserver on 'localhost:37198' 08:47:11 INFO - SUITE-START | Running 2 tests 08:47:11 INFO - TEST-START | dromaeo_css 08:47:11 INFO - Initialising browser for dromaeo_css test... 08:47:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37198/getInfo.html -profile /tmp/tmphyCaHR/profile 08:47:11 INFO - TEST-INFO | started process 18295 (/builds/slave/test/build/application/firefox/firefox http://localhost:37198/getInfo.html) 08:47:17 INFO - TEST-INFO | 18295: exit 0 08:47:17 INFO - Browser initialized. 08:47:17 INFO - Running cycle 1/1 for dromaeo_css test... 08:47:17 INFO - TEST-INFO | started process 18471 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphyCaHR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:18 INFO - PID 18471 | 08:47:18 INFO - PID 18471 | (/builds/slave/test/build/application/firefox/firefox:18521): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:47:18 INFO - PID 18471 | 08:47:19 INFO - PID 18471 | 08:47:19 INFO - PID 18471 | (/builds/slave/test/build/application/firefox/firefox:18576): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:47:19 INFO - PID 18471 | 08:47:19 INFO - PID 18471 | __metrics Screen width/height:1600/1200 08:47:19 INFO - PID 18471 | colorDepth:24 08:47:19 INFO - PID 18471 | Browser inner width/height: 1024/768 08:47:19 INFO - PID 18471 | __metrics 08:47:28 INFO - PID 18471 | RSS: Main: 165539840 08:47:28 INFO - PID 18471 | 08:50:27 INFO - PID 18471 | Cycle 1(1): loaded http://localhost:37198/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37198/tests/dromaeo/cssquery-ext.html) 08:50:29 INFO - PID 18471 | RSS: Main: 170012672 08:50:29 INFO - PID 18471 | 08:53:30 INFO - PID 18471 | Cycle 1(1): loaded http://localhost:37198/tests/dromaeo/cssquery-ext.html (next: http://localhost:37198/tests/dromaeo/cssquery-jquery.html) 08:53:31 INFO - PID 18471 | RSS: Main: 166490112 08:53:31 INFO - PID 18471 | 08:56:32 INFO - PID 18471 | Cycle 1(1): loaded http://localhost:37198/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37198/tests/dromaeo/cssquery-mootools.html) 08:56:33 INFO - PID 18471 | RSS: Main: 168828928 08:56:33 INFO - PID 18471 | 08:59:35 INFO - PID 18471 | Cycle 1(1): loaded http://localhost:37198/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37198/tests/dromaeo/cssquery-prototype.html) 08:59:35 INFO - PID 18471 | RSS: Main: 166846464 08:59:35 INFO - PID 18471 | 09:02:38 INFO - PID 18471 | Cycle 1(1): loaded http://localhost:37198/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37198/tests/dromaeo/cssquery-yui.html) 09:02:39 INFO - PID 18471 | RSS: Main: 170885120 09:02:39 INFO - PID 18471 | 09:05:40 INFO - PID 18471 | Cycle 1(1): loaded http://localhost:37198/tests/dromaeo/cssquery-yui.html (next: http://localhost:37198/tests/dromaeo/cssquery-dojo.html) 09:05:41 INFO - PID 18471 | RSS: Main: 170893312 09:05:41 INFO - PID 18471 | 09:05:41 INFO - PID 18471 | __start_tp_report 09:05:41 INFO - PID 18471 | _x_x_mozilla_page_load 09:05:41 INFO - PID 18471 | _x_x_mozilla_page_load_details 09:05:41 INFO - PID 18471 | |i|pagename|runs| 09:05:41 INFO - PID 18471 | |0;dojo.html;3855.8650447234354;3866.052817059819;3918.451416801647;3921.490206273184;3951.111000024993;6118.296395914471;6228.688565571721;6240.032794916795;6308.211473565804;6318.557700960934;6100.603460775058;6196.039613859848;6219;6232.2521297444255;6255.624662520252;5603;5617.4382561743905;5627.2684551008315;5645.717714114298;5663.2637757091525;5649.0396632572565;5656.802011929583;5664.20701101846;5666.065099258617;5736.2256095427;5708.172315014342;5715.571332150084;5720.485156335929;5733.913991290134;5747.166660834177;5614.326280846284;5654.830355089333;5712.171735098429;5754.395788442237;5766.452187042224;5406.270153529302;5477.178423236506;5575.944240557583;5580.91628625571;5592.5805564582815;6218.129461875341;6224.377562243784;6230.750769969196;6340.953742632506;6358.173437453148;6721.227058888193;6727.461803055744;6735.966320168368;6829.7609583664835;6849.2808255132995;6813;6822.761203357908;6837.247902730695;6862.862742745117;6909.447244220451;6307.211598550181;6379.298277189506;6390.680465976682;6390.904136438004;6393.7762178324;6926.8614627708175;6928.237893831674;7030.894536581955;7032.507724459341;7033.226345102034;6567.573107747981;6608.240052394036;6649.60102393858;6722.462203023844;6798.184217893884;6700.195976482853;6754.763583274562;6775.220849602359;6801.829954251183;6816.113905192294;6679.2318883329035;6699.363560461846;6764.695588698521;6775.119234499483;6786.8642627148165;6579.30917253691;6628.23775265841;6630.436412904957;6679.799606011828;6737.258901520829;5024.171011783015;5028.396592408934;5029.698218106925;5034.144195486703;5077.416097148875;4591.288350305708;4697.882552936204;4710.458297295855;4721;4725.5983241424865;6144.4469997699525;6146.78486252979;6241.687915604201;6246.125542424064;6321.494280457644;6738.157730283715;6748;6748.257691653914;6752.08846805675;6757.594544327258;6106.236720409949;6156.538259630545;6157.291911430243;6167.660778657217;6243.344448832807;5673.687947162863;5678.14827775837;5682.6306290091015;5682.715864206856;5685.431456854281;7041.753538626226;7043.894341584881;7058.364747172676;7150.570965742072;7153.427725781925;6610.603363798187;6718;6722.462203023844;6764.492663050192;6810.62541560219;6871.14110736158;6931.653417329214;6973.267806880407;7018.684159212949;7051.048108505286;6622.271550129578;6674.83312917181;6720.798376048726;6749.3250674932115;6754.966225168842;6728.831779205559;6753.3246675332075;6830.419414349836;6835.863282734417;6856.897146542706;6470.255920569007;6473.48212143018;6524.347565243438;6530.314316996837;6533.020046992989;6476.028595710681;6496.545241833026;6529.314421985623;6559.836004099936;6567.835804104936;6453.51598630114;6466.4503517201565;6552.868942621216;6553.770618028346;6556.803295901131;6534.803955881332;6536.150300460909;6585.473162146921;6605;6623.966880165568;6269.404406581368;6365.7135428904885;6374.4900407966325;6445.903311450238;6449.193850768654 09:05:41 INFO - PID 18471 | |1;ext.html;881.8192270584531;920.8250432417836;947.6209516193521;970.6893793985919;972.7324985628951;40253.59746402535;41207.58792412075;41247.175056498854;41489.377659335136;41618.58381416185;38238.23523529528;38345.616543834556;38393.424098638476;38431.423528647094;38549.421758673576;7140.607266600335;7270;7270.236625154335;7272.745453909114;7277.017602623631;7133.750318738845;7223.783286501413;7226.458015648821;7230.855382892339;7755.72854950074;7972.601369931509;7995.320397766197;8003.279704826565;8020.879686804703;8026.879596806052;7816.296533312029;7893.684252629888;7905.565193914333;7939.960300198491;7946.721864734735;7715.884261736079;7791.415643826679;7797.961010194969;7799.103103143155;7800.570968596725;38813.41779873276;39259.60740392588;39262.60737392647;39284;39296.607033929584;3569.7679650822615;3585.1395665040463;3597.6762091411897;3598.6941110005682;3613.421852503613;30652.84673576618;30782.692173078205;30877;30894.691053089406;30937.535936960965;5319.787208511655;5331.147016477384;5342.946570534284;5348.277982472394;5365.704886231256;195853;198100;203544;204799;209366;50923;51269.743651281504;51304.48695512997;51423.7428812861;51430.22854657183;53709.73145134327;53818.46181538213;53883.46116538863;53898.730506347216;53899.73050134724;16383.67232655364;16451.42420015294;16526.504204873872;16568.17159142038;16750.74873876893;13660.180389176483;13669;13674.384652690653;13679.179249245077;13694;14594.197319147548;14617.90365722575;14623.853761462462;14722.190279534729;14774.704505909822;5631.690257035821;5717.428257174332;5721.227634269404;5724;5770.942290577041;1035.5133087448887;1047.0942634621;1048.3709774135457;1063.6489958313894;1065.4779158212575;24210.273691789276;24284.514309713708;24357.63463548048;24425.877870610533;24595.877020615142;1119.6864877834219;1134.920555561103;1145.799485090106;1162.7790719763218;1164.9748221565137;12733.808992865115;12901.225926444444;12922.483100676056;12982.221066736027;13013.154144980546;276928;281789;283096;283517;283579;61515;61905.69047154736;62061.37938620646;62324.688376557824;62408.68795655993;1459.2776575595149;1492.9701405972037;1501.8573235542606;1513.9470118545798;1517.8254500732558;28259.717402825707;28537.571936421387;29081.709182908748;29160;29869;54762.17856732073;55033.449665502834;55093;55120;55271;243304;245217;246190;246644;246802;37358.439623406215;38661.42007869828;39739;39800.80099599483;39824.80087599543;47236.52763472459;48881.5111848877;48919.266211007576;49287.50712492829;49345.50654493409;35636;35689.1077723059;35730.64269357273;36578.45132322964;36756.632433675324;35564.466533001505;35673.46489802603;35742;35782.82108589545;35959.64040359563;39958.200835982534;40058.79970600245;40229.597704022584;40319.39520907247;40367;33995;34265;34271;34541.30917381689;34789.65210347864;25449.236522904343;25542.616860747476;25686.213817135886;26292.73707262903;26449.735502645497 09:05:41 INFO - PID 18471 | |2;jquery.html;573.3664300947453;587.239524815364;594.3165359836188;598.8083813179782;599.313785715356;21345.25291614794;22234.88882555587;23126.88436557817;23129.884350578224;23146.88426557867;24843.50312993739;25227.747722522814;25429.364265893317;25462.108826191088;25465.745342546616;6385.936140638604;6504.284528701839;6511.120998665167;6511.674416279191;6520.250171230298;5808.854778630526;6147.862645410613;6223.564350495444;6230.750769969219;6295.150154729099;6187.845303867417;6220.066989951521;6247.15663385444;6249.406306400907;6256;6148.600340977822;6193.102000209944;6221.688915554227;6250.562460627758;6258.749650013994;5810.7385167667135;5834.095715164156;5847.736851841677;5849.2103566018895;5887.646741195542;28365.858170709016;29459.263518411997;29722;29843.850780745957;29973.70026299731;2274.9658755118685;2305.7348404933477;2306.2504685977124;2306.550222706573;2307.3308740465245;19809;20488.38534843957;20523.281685141097;20529.79470205294;20551.075201615964;2369.218158007853;2442.7801497865275;2484.291976786607;2522.672052633164;2546;152903;155575.22212388978;155666;155754.22122889425;156460;14384.35270412834;15430;15706.528804135894;15725.606859828596;15884.841151588567;24787.25638230856;24794.5041099177;24802.25593232206;24822.255332340057;24852.37869053288;10368.896311036944;10390.740231494274;10438.843417348595;10450.581976720847;10674.146068314516;8754.781130471789;9104.635814567344;9569.425834449956;9633.614655413705;9742.659006934724;9004.279657627374;9556.187724043395;9659.517024148765;9687.70936871895;9884.406935583887;2741.7943654226015;2749.3539018330675;2767.114523352548;2799.90200342987;2806.593044008607;993.7118235711563;1009.9747506312254;1015.7359086637528;1020.8468729690458;1024.0527512051324;20228.494287642927;20580.691289630668;20606;20825.479363015744;21163.15347386118;1044.5612842606124;1075.424647813416;1100.757833276678;1101.1796211822243;1106.115107913666;11059.668209953714;11480.311181329147;11531.019863311712;11578.47896844644;11618.199318747555;601974;608021;615145;617312;622294;127117.36441317735;132483;132684.3365783165;135674;136387.31806340904;1284.569669160823;1319.973600527984;1346.9326533673473;1350.3923234544495;1360.9183448993092;21966.231181908555;22275.66586501236;22816.885915570318;23129.306120816404;24151.879240603685;65033.67483162554;65461.67269163624;67456.325436745;67645.66177169082;68349.31650683629;84480.57759711162;84897.57551212204;85377;86687.13312867042;88042.55978720065;22385.44036399103;22977.50646208058;23031.769682302962;23063.88468057649;23123.537529249657;24653.38366540851;24712.752872471763;24823;24946.62580061264;24981.75018249794;19537.316193933144;19953.900230498755;20087.096080676696;20088.096035678136;20132.597348052663;17891.552711182325;18004.18981145878;18049.458516244533;18138.54653633617;18209.271629134688;20058.799412006276;20341.27099196585;20411.285605003755;20453.2841350552;20525.48686282795;21660.783392165875;22059;22180.778192217873;22280.77719222787;22424.327270181922;19526.121324540145;19861.702074469184;19889.303874364326;20107.195712171935;20146.899265504166 09:05:41 INFO - PID 18471 | |3;mootools.html;1374.9312534373282;1411.8870490360773;1425.5295752401705;1440.4958264607383;1443.3504922784743;15636.35818239084;16210.918945405256;16296.83703162968;16311.510654680349;16311.510654680364;16520.339186432557;16809.83190168098;16820.663586728257;16821.747673784874;16826.915865420655;2627.842329460229;2723.6595425571804;2784.8050636455455;2822.1533539937936;2822.717728227171;2773.3066733316673;2808.9016884409048;2809.1712944681267;2811.803173777826;2813.395120049189;2728.7271272872754;2743.341598016472;2783.067672329772;2787.28924124348;2791.3719413131985;2669.706332303445;2690.8116431849876;2705.053231369015;2716.891324347024;2718.374773802017;2715.253305341047;2735.2341344423594;2743.9451210975667;2746.0114358830806;2748.2991837081618;15726.606834829221;15792;15925.203739812963;15928.362865485367;15928.681426371408;8210.096889342167;8399.37004724642;8440.071592124861;8441.198086181803;8445.873311900326;5397.46025397461;5542;5642.097264437671;5744.8851022979725;5762.394948530386;1981.5442448236986;1990.2536548794203;1998.7301714268533;1999.3901859932714;2060.3406909788873;28159.577606335923;28421.57367639487;28428.431431371257;28439.85780071107;28467.145985620256;7140.642967851587;7247.20280769115;7261.8547629047125;7302.56184628924;7365.189829118793;18742;18747.718784218247;18764;18766.437006889813;18774.436766897015;8314.501129932223;8458.323334133254;8483.787905302293;8486.151384861589;8493.745187644381;7437.590932498656;7575.621218939031;7607.733729319447;7617.352525035434;7682.201251892116;5365.7585408656705;5570.554355651539;5584.944150558524;5604.85987850307;5633.69014704187;1629.120275051459;1634.6240364716182;1637.4596383193518;1649.496903444461;1668.8414600612923;867.1328671328671;898.5462341517492;909.3495306019553;911.4667919267171;915.4827522449795;7781.144074151839;7798.064232292161;7821.882671759929;7831.295183433518;7863.685452581833;740.6666999850089;742.8922806193071;758.1887380502809;762.6911101004102;769.4267770510893;4949.802007919715;5330.813421530228;5406.59450541211;5492.5331346835965;5592.692401917852;23025.078996840275;23773;23783.52432951331;23858.52282954331;23985.52028959446;22130.114795408324;23081.192158274716;23094.98760987814;23267.650985235236;23433.41416464568;12324.938375308066;12438.81341779874;12589.874101259053;12606.369681515887;12617.495300188073;9733.561989710339;9884.209263259067;10006.44964526958;10020.799584008133;10093.697189084045;19851.30520431778;20675.68986465174;20683.896580517605;20811.687824682944;20920;20174;20640.79359206389;20680.276190333265;21087.578248435253;21418.250361237282;12853.742925141632;13239.66900827487;13244.735105297646;13276;13282.269475178959;14735.92632036833;14844.554663360117;14877.40490380416;15046.774298385752;15074.773878392052;11363.204575679623;11517.884821151682;11558.30650160993;11675.941620291844;11849.52601895949;10949.178811589003;11203.15976301797;11350.94324528372;11469.426528673699;11549.36478493691;10144.391336519833;10787.352758834495;10787.352758834495;10798.244122911321;10799.622013229813;8181.222783835526;8181.386396020203;8219.95890020546;8266.504009759434;8281.461704989157;7838.882416763639;7947.960260198662;7991.520508769492;8008.519488830689;8087.433879628369 09:05:41 INFO - PID 18471 | |4;prototype.html;538.6660270632208;541.9268398766166;556.5686592890511;561.8650326340792;563.5547917145452;6119.632822030676;6137.355577664348;6142.1708069410615;6161.568690191689;6225.937740622592;6043.788467403641;6078.057901025348;6098.725557349919;6153.723082461289;6167.568270221086;5086.186210206368;5087.364079490064;5099.745012749367;5109.412417571971;5117.462666420028;4861.489543597924;4879.536444037811;5077.213031980031;5096.439391666913;5113.312606839734;4826.17954947658;4859.392575928009;4860.2466617674145;4908.263760435928;4961.330220420251;4872.196087645534;4906.165951788204;4941.160002799515;4950.727709975949;4964.453910069889;4376.978115109436;4415.66882483815;4465.218586747306;4483.50681425043;4495.145922274757;5938.346781853993;5958.225430693982;6010.699465026775;6038.63768173911;6074.817755467343;5692.31692196939;5699.145128230757;5742.368339482654;5764.971175144139;5771.653700777924;6524.956007038851;6544.247411547685;6597.208334999783;6610.867782644368;6613.173353330833;4930.556249937487;4931.3835770528685;4945.876353091202;4954.108260513106;4975.353204083446;6569.770058047945;6577.769778057745;6655.670515319599;6717.63053032083;6779.830504237384;4972.950270497248;4998.950010499849;5027.039454612704;5034.647574669812;5054.671446355975;5097.668651537638;5100.158473851773;5119.436861945183;5120.48795120485;5146.87132821675;5627.634203776742;5656.830295091154;5664.433556644385;5672.546196304285;5718.656880587178;6431.228252609717;6460.257070436866;6509.2750421138435;6536.542442029012;6553.475721942234;1785.276962830056;1788.9105544722972;1798.2357498063532;1802.585405356749;1811.166863242923;1170.7014711248578;1240.4108048676987;1244.8319476870506;1249.3815561297035;1254.5483625894672;6093.329733729286;6134;6222.906656400158;6228.47058000066;6249.281332646804;6573.342665733484;6613.537052406382;6688.598684078874;6738.797836064828;6774.593524388552;6134.5092392608485;6136.140940268366;6170.691465426711;6178.135061091451;6193.4425901669065;3505.895642872487;3519.63043880394;3520.4543295789194;3526.5944416392445;3553.200529880756;6570.671466426659;6776.42400395962;6991.30086991307;6994.965025174842;7001.439884809305;6637.369449902251;6701.262861085277;6706.5640733352175;6722.899156512656;6771.747226763065;6753.15585551806;6820.829479263058;6862.965685171642;6896.551724137858;6941.930580694229;6461.935380646133;6505.967470162619;6541.574797638138;6570.47436205112;6667.733290668513;6471.741130354733;6574.53978221539;6582.670866456562;6610.3720146586;6630.088247933742;6899.17209934811;6913.688884000333;6959.26927672587;6968.163820341591;6998.580085194701;5077.619178561548;5096.439391666988;5099.719515426687;5101.336826212569;5102.4642412546145;6512.706928188148;6589.715005573867;6611.206655201407;6647.867042659216;6697.229818570732;6344.619322840645;6390.648514331757;6410.1987251593555;6435.742570297136;6470.611763294218;6358.332375100733;6404.487640988803;6474.482041436768;6518.608883467007;6519.152510173647;6218.409251121137;6346.587471814318;6369.293050453446;6378.330275321025;6447.548671592944;6430.292667806444;6467.547271690936;6497.512686548623;6518.087467754423;6574.704138313883;6309.936900630935;6342;6350.650714210763;6355.936440635534;6432.388923052303 09:05:41 INFO - PID 18471 | |5;yui.html;960.1071003966308;964.0744884910486;985.5909797434065;992.1665800727387;994.4083270454078;19341.806581934175;19366.99999999998;19585.118669659863;19589.314373996913;20551.897240513816;20742.48143796406;21168.788312116874;21264.8936755316;21296.254631087915;21305;1048.6696690542474;1059.6662051453807;1063.0485715284815;1064.8668916385452;1066.786642671465;1048.8426735989585;1069.8662667166604;1070.812607793637;1075.537518866887;1090.1061129873508;1139.0545846947055;1139.5840518210834;1141.1384404774383;1141.8058929981883;1142.5087212498622;1120.787050460418;1127.1039523578775;1127.667338135252;1127.6729748373002;1128.6049882541167;829.0010537302536;830.2776584371635;830.4892491117979;830.5349004557468;831.301706566487;17358.65282694339;17583.472495825146;17608.383706570337;18375.540611484685;20683.689744653842;22058;22190.334289971328;22266.443338916495;22741.772582274298;22749.772502275096;15554.688906221812;15996;16120.193990300555;16131.516054518266;16197.02817830934;3890.1247219375696;3920.313945059603;3920.9607903920883;3923.058465968176;3923.293807114718;144137.27931360382;145145.274273629;145276;145277;145522.26155457075;16582.917085414494;16855;16901.577460563585;16983.320667173422;16991.40530081441;32675.509867352008;33385.66614333874;33456.665433345355;33561.83219083938;33648;8647.697330593399;8827.16141966512;8834.116588341114;8864.157904999014;8884.555772211364;4255.680823938217;4317.460317460317;4333.458317710286;4335.804888780012;4337.110892267077;5684.77260909559;5754.309482862083;5760.222369979999;5790.565707571949;5815.563832712563;1084.69628504019;1107.429673718036;1110.3227031510771;1121.820508718601;1125.454154734953;690.6063543779998;707.2715103443359;707.8002785278903;718.683779137178;722.2777222777223;11994.760104797855;12003.1597788154;12103.455344509519;12180.147389682637;12499.125061245808;693.0782059860373;701.8561194955022;711.210556282526;725.8512005039059;726.0307489501469;5530.198121272393;5605.5515558756015;5674.886502270014;5707.001274776898;5755.107958266475;128033;131770;132755;135257;135477;117478;117532;118746;119285;121614;101071.49464252779;101353.49323253483;103048;103884.48057759662;104577;10374.962503749564;10747.301425407324;10809.459527023775;10856.131509479064;11139.05318047975;49787;49963;51052.74473627608;51216.487835122665;51367.229491558406;62700.372996269456;63451;63535;64041.35958640354;64619.353806463216;15943.282552285407;16122.596935076717;16125.838741612903;16136.354545818505;16144.838551614803;23096.538069238184;23528.529429411657;23720.40698982539;24106.758932411154;24450.388740281636;21278.255261065788;21425;21515.246966356102;21678.132874685467;21886.45283867916;18096.72854907204;18231.726524102414;18248;18387;18411.72382414238;19106.522336941132;20033.198672052953;20264.696029559862;21453.89273053625;21674.34976950694;13687.247201404018;14756.852431475978;14937.77593336079;15342.693146137239;15678.843211567739;15846.207689615703;16052.277647505656;16294.022358658518;16427.260773265472;16766.66466670684 09:05:41 INFO - PID 18471 | __end_tp_report 09:05:41 INFO - PID 18471 | __start_cc_report 09:05:41 INFO - PID 18471 | _x_x_mozilla_cycle_collect,356 09:05:41 INFO - PID 18471 | __end_cc_report 09:05:41 INFO - PID 18471 | __startTimestamp1503504341231__endTimestamp 09:05:41 INFO - PID 18471 | 09:05:41 INFO - PID 18471 | ------- Summary: start ------- 09:05:41 INFO - PID 18471 | Number of tests: 6 09:05:41 INFO - PID 18471 | 09:05:41 INFO - PID 18471 | [#0] dojo.html Cycles:165 Average:6243.45 Median:6470.26 stddev:703.41 (10.9%) stddev-sans-first:680.17 09:05:41 INFO - PID 18471 | Values: 3855.9 3866.1 3918.5 3921.5 3951.1 6118.3 6228.7 6240.0 6308.2 6318.6 6100.6 6196.0 6219.0 6232.3 6255.6 5603.0 5617.4 5627.3 5645.7 5663.3 5649.0 5656.8 5664.2 5666.1 5736.2 5708.2 5715.6 5720.5 5733.9 5747.2 5614.3 5654.8 5712.2 5754.4 5766.5 5406.3 5477.2 5575.9 5580.9 5592.6 6218.1 6224.4 6230.8 6341.0 6358.2 6721.2 6727.5 6736.0 6829.8 6849.3 6813.0 6822.8 6837.2 6862.9 6909.4 6307.2 6379.3 6390.7 6390.9 6393.8 6926.9 6928.2 7030.9 7032.5 7033.2 6567.6 6608.2 6649.6 6722.5 6798.2 6700.2 6754.8 6775.2 6801.8 6816.1 6679.2 6699.4 6764.7 6775.1 6786.9 6579.3 6628.2 6630.4 6679.8 6737.3 5024.2 5028.4 5029.7 5034.1 5077.4 4591.3 4697.9 4710.5 4721.0 4725.6 6144.4 6146.8 6241.7 6246.1 6321.5 6738.2 6748.0 6748.3 6752.1 6757.6 6106.2 6156.5 6157.3 6167.7 6243.3 5673.7 5678.1 5682.6 5682.7 5685.4 7041.8 7043.9 7058.4 7150.6 7153.4 6610.6 6718.0 6722.5 6764.5 6810.6 6871.1 6931.7 6973.3 7018.7 7051.0 6622.3 6674.8 6720.8 6749.3 6755.0 6728.8 6753.3 6830.4 6835.9 6856.9 6470.3 6473.5 6524.3 6530.3 6533.0 6476.0 6496.5 6529.3 6559.8 6567.8 6453.5 6466.5 6552.9 6553.8 6556.8 6534.8 6536.2 6585.5 6605.0 6624.0 6269.4 6365.7 6374.5 6445.9 6449.2 09:05:41 INFO - PID 18471 | 09:05:41 INFO - PID 18471 | [#1] ext.html Cycles:180 Average:42507.56 Median:37798.34 stddev:63930.64 (169.1%) stddev-sans-first:64033.58 09:05:41 INFO - PID 18471 | Values: 881.8 920.8 947.6 970.7 972.7 40253.6 41207.6 41247.2 41489.4 41618.6 38238.2 38345.6 38393.4 38431.4 38549.4 7140.6 7270.0 7270.2 7272.7 7277.0 7133.8 7223.8 7226.5 7230.9 7755.7 7972.6 7995.3 8003.3 8020.9 8026.9 7816.3 7893.7 7905.6 7940.0 7946.7 7715.9 7791.4 7798.0 7799.1 7800.6 38813.4 39259.6 39262.6 39284.0 39296.6 3569.8 3585.1 3597.7 3598.7 3613.4 30652.8 30782.7 30877.0 30894.7 30937.5 5319.8 5331.1 5342.9 5348.3 5365.7 195853.0 198100.0 203544.0 204799.0 209366.0 50923.0 51269.7 51304.5 51423.7 51430.2 53709.7 53818.5 53883.5 53898.7 53899.7 16383.7 16451.4 16526.5 16568.2 16750.7 13660.2 13669.0 13674.4 13679.2 13694.0 14594.2 14617.9 14623.9 14722.2 14774.7 5631.7 5717.4 5721.2 5724.0 5770.9 1035.5 1047.1 1048.4 1063.6 1065.5 24210.3 24284.5 24357.6 24425.9 24595.9 1119.7 1134.9 1145.8 1162.8 1165.0 12733.8 12901.2 12922.5 12982.2 13013.2 276928.0 281789.0 283096.0 283517.0 283579.0 61515.0 61905.7 62061.4 62324.7 62408.7 1459.3 1493.0 1501.9 1513.9 1517.8 28259.7 28537.6 29081.7 29160.0 29869.0 54762.2 55033.4 55093.0 55120.0 55271.0 243304.0 245217.0 246190.0 246644.0 246802.0 37358.4 38661.4 39739.0 39800.8 39824.8 47236.5 48881.5 48919.3 49287.5 49345.5 35636.0 35689.1 35730.6 36578.5 36756.6 35564.5 35673.5 35742.0 35782.8 35959.6 39958.2 40058.8 40229.6 40319.4 40367.0 33995.0 34265.0 34271.0 34541.3 34789.7 25449.2 25542.6 25686.2 26292.7 26449.7 09:05:41 INFO - PID 18471 | 09:05:41 INFO - PID 18471 | [#2] jquery.html Cycles:180 Average:40743.57 Median:23129.60 stddev:102708.57 (444.1%) stddev-sans-first:102952.41 09:05:41 INFO - PID 18471 | Values: 573.4 587.2 594.3 598.8 599.3 21345.3 22234.9 23126.9 23129.9 23146.9 24843.5 25227.7 25429.4 25462.1 25465.7 6385.9 6504.3 6511.1 6511.7 6520.3 5808.9 6147.9 6223.6 6230.8 6295.2 6187.8 6220.1 6247.2 6249.4 6256.0 6148.6 6193.1 6221.7 6250.6 6258.7 5810.7 5834.1 5847.7 5849.2 5887.6 28365.9 29459.3 29722.0 29843.9 29973.7 2275.0 2305.7 2306.3 2306.6 2307.3 19809.0 20488.4 20523.3 20529.8 20551.1 2369.2 2442.8 2484.3 2522.7 2546.0 152903.0 155575.2 155666.0 155754.2 156460.0 14384.4 15430.0 15706.5 15725.6 15884.8 24787.3 24794.5 24802.3 24822.3 24852.4 10368.9 10390.7 10438.8 10450.6 10674.1 8754.8 9104.6 9569.4 9633.6 9742.7 9004.3 9556.2 9659.5 9687.7 9884.4 2741.8 2749.4 2767.1 2799.9 2806.6 993.7 1010.0 1015.7 1020.8 1024.1 20228.5 20580.7 20606.0 20825.5 21163.2 1044.6 1075.4 1100.8 1101.2 1106.1 11059.7 11480.3 11531.0 11578.5 11618.2 601974.0 608021.0 615145.0 617312.0 622294.0 127117.4 132483.0 132684.3 135674.0 136387.3 1284.6 1320.0 1346.9 1350.4 1360.9 21966.2 22275.7 22816.9 23129.3 24151.9 65033.7 65461.7 67456.3 67645.7 68349.3 84480.6 84897.6 85377.0 86687.1 88042.6 22385.4 22977.5 23031.8 23063.9 23123.5 24653.4 24712.8 24823.0 24946.6 24981.8 19537.3 19953.9 20087.1 20088.1 20132.6 17891.6 18004.2 18049.5 18138.5 18209.3 20058.8 20341.3 20411.3 20453.3 20525.5 21660.8 22059.0 22180.8 22280.8 22424.3 19526.1 19861.7 19889.3 20107.2 20146.9 09:05:41 INFO - PID 18471 | 09:05:41 INFO - PID 18471 | [#3] mootools.html Cycles:180 Average:10022.93 Median:2697.93 stddev:7271.95 (269.5%) stddev-sans-first:7263.32 09:05:41 INFO - PID 18471 | Values: 1374.9 1411.9 1425.5 1440.5 1443.4 15636.4 16210.9 16296.8 16311.5 16311.5 16520.3 16809.8 16820.7 16821.7 16826.9 2627.8 2723.7 2784.8 2822.2 2822.7 2773.3 2808.9 2809.2 2811.8 2813.4 2728.7 2743.3 2783.1 2787.3 2791.4 2669.7 2690.8 2705.1 2716.9 2718.4 2715.3 2735.2 2743.9 2746.0 2748.3 15726.6 15792.0 15925.2 15928.4 15928.7 8210.1 8399.4 8440.1 8441.2 8445.9 5397.5 5542.0 5642.1 5744.9 5762.4 1981.5 1990.3 1998.7 1999.4 2060.3 28159.6 28421.6 28428.4 28439.9 28467.1 7140.6 7247.2 7261.9 7302.6 7365.2 18742.0 18747.7 18764.0 18766.4 18774.4 8314.5 8458.3 8483.8 8486.2 8493.7 7437.6 7575.6 7607.7 7617.4 7682.2 5365.8 5570.6 5584.9 5604.9 5633.7 1629.1 1634.6 1637.5 1649.5 1668.8 867.1 898.5 909.3 911.5 915.5 7781.1 7798.1 7821.9 7831.3 7863.7 740.7 742.9 758.2 762.7 769.4 4949.8 5330.8 5406.6 5492.5 5592.7 23025.1 23773.0 23783.5 23858.5 23985.5 22130.1 23081.2 23095.0 23267.7 23433.4 12324.9 12438.8 12589.9 12606.4 12617.5 9733.6 9884.2 10006.4 10020.8 10093.7 19851.3 20675.7 20683.9 20811.7 20920.0 20174.0 20640.8 20680.3 21087.6 21418.3 12853.7 13239.7 13244.7 13276.0 13282.3 14735.9 14844.6 14877.4 15046.8 15074.8 11363.2 11517.9 11558.3 11675.9 11849.5 10949.2 11203.2 11350.9 11469.4 11549.4 10144.4 10787.4 10787.4 10798.2 10799.6 8181.2 8181.4 8220.0 8266.5 8281.5 7838.9 7948.0 7991.5 8008.5 8087.4 09:05:41 INFO - PID 18471 | 09:05:41 INFO - PID 18471 | [#4] prototype.html Cycles:180 Average:5535.22 Median:6157.65 stddev:1543.87 (25.1%) stddev-sans-first:1501.96 09:05:41 INFO - PID 18471 | Values: 538.7 541.9 556.6 561.9 563.6 6119.6 6137.4 6142.2 6161.6 6225.9 6043.8 6078.1 6098.7 6153.7 6167.6 5086.2 5087.4 5099.7 5109.4 5117.5 4861.5 4879.5 5077.2 5096.4 5113.3 4826.2 4859.4 4860.2 4908.3 4961.3 4872.2 4906.2 4941.2 4950.7 4964.5 4377.0 4415.7 4465.2 4483.5 4495.1 5938.3 5958.2 6010.7 6038.6 6074.8 5692.3 5699.1 5742.4 5765.0 5771.7 6525.0 6544.2 6597.2 6610.9 6613.2 4930.6 4931.4 4945.9 4954.1 4975.4 6569.8 6577.8 6655.7 6717.6 6779.8 4973.0 4999.0 5027.0 5034.6 5054.7 5097.7 5100.2 5119.4 5120.5 5146.9 5627.6 5656.8 5664.4 5672.5 5718.7 6431.2 6460.3 6509.3 6536.5 6553.5 1785.3 1788.9 1798.2 1802.6 1811.2 1170.7 1240.4 1244.8 1249.4 1254.5 6093.3 6134.0 6222.9 6228.5 6249.3 6573.3 6613.5 6688.6 6738.8 6774.6 6134.5 6136.1 6170.7 6178.1 6193.4 3505.9 3519.6 3520.5 3526.6 3553.2 6570.7 6776.4 6991.3 6995.0 7001.4 6637.4 6701.3 6706.6 6722.9 6771.7 6753.2 6820.8 6863.0 6896.6 6941.9 6461.9 6506.0 6541.6 6570.5 6667.7 6471.7 6574.5 6582.7 6610.4 6630.1 6899.2 6913.7 6959.3 6968.2 6998.6 5077.6 5096.4 5099.7 5101.3 5102.5 6512.7 6589.7 6611.2 6647.9 6697.2 6344.6 6390.6 6410.2 6435.7 6470.6 6358.3 6404.5 6474.5 6518.6 6519.2 6218.4 6346.6 6369.3 6378.3 6447.5 6430.3 6467.5 6497.5 6518.1 6574.7 6309.9 6342.0 6350.7 6355.9 6432.4 09:05:41 INFO - PID 18471 | 09:05:41 INFO - PID 18471 | [#5] yui.html Cycles:180 Average:26474.42 Median:19354.40 stddev:37767.54 (195.1%) stddev-sans-first:37824.90 09:05:41 INFO - PID 18471 | Values: 960.1 964.1 985.6 992.2 994.4 19341.8 19367.0 19585.1 19589.3 20551.9 20742.5 21168.8 21264.9 21296.3 21305.0 1048.7 1059.7 1063.0 1064.9 1066.8 1048.8 1069.9 1070.8 1075.5 1090.1 1139.1 1139.6 1141.1 1141.8 1142.5 1120.8 1127.1 1127.7 1127.7 1128.6 829.0 830.3 830.5 830.5 831.3 17358.7 17583.5 17608.4 18375.5 20683.7 22058.0 22190.3 22266.4 22741.8 22749.8 15554.7 15996.0 16120.2 16131.5 16197.0 3890.1 3920.3 3921.0 3923.1 3923.3 144137.3 145145.3 145276.0 145277.0 145522.3 16582.9 16855.0 16901.6 16983.3 16991.4 32675.5 33385.7 33456.7 33561.8 33648.0 8647.7 8827.2 8834.1 8864.2 8884.6 4255.7 4317.5 4333.5 4335.8 4337.1 5684.8 5754.3 5760.2 5790.6 5815.6 1084.7 1107.4 1110.3 1121.8 1125.5 690.6 707.3 707.8 718.7 722.3 11994.8 12003.2 12103.5 12180.1 12499.1 693.1 701.9 711.2 725.9 726.0 5530.2 5605.6 5674.9 5707.0 5755.1 128033.0 131770.0 132755.0 135257.0 135477.0 117478.0 117532.0 118746.0 119285.0 121614.0 101071.5 101353.5 103048.0 103884.5 104577.0 10375.0 10747.3 10809.5 10856.1 11139.1 49787.0 49963.0 51052.7 51216.5 51367.2 62700.4 63451.0 63535.0 64041.4 64619.4 15943.3 16122.6 16125.8 16136.4 16144.8 23096.5 23528.5 23720.4 24106.8 24450.4 21278.3 21425.0 21515.2 21678.1 21886.5 18096.7 18231.7 18248.0 18387.0 18411.7 19106.5 20033.2 20264.7 21453.9 21674.3 13687.2 14756.9 14937.8 15342.7 15678.8 15846.2 16052.3 16294.0 16427.3 16766.7 09:05:41 INFO - PID 18471 | -------- Summary: end -------- 09:05:41 INFO - PID 18471 | 09:05:42 INFO - TEST-INFO | 18471: exit 0 09:05:42 INFO - TEST-OK | dromaeo_css | took 1110904ms 09:05:42 INFO - TEST-START | kraken 09:05:42 INFO - Initialising browser for kraken test... 09:05:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37198/getInfo.html -profile /tmp/tmpInkMS5/profile 09:05:42 INFO - TEST-INFO | started process 18882 (/builds/slave/test/build/application/firefox/firefox http://localhost:37198/getInfo.html) 09:05:48 INFO - TEST-INFO | 18882: exit 0 09:05:48 INFO - Browser initialized. 09:05:48 INFO - Running cycle 1/1 for kraken test... 09:05:48 INFO - TEST-INFO | started process 19055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpInkMS5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:49 INFO - PID 19055 | 09:05:49 INFO - PID 19055 | (/builds/slave/test/build/application/firefox/firefox:19107): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:05:49 INFO - PID 19055 | 09:05:49 INFO - PID 19055 | 09:05:49 INFO - PID 19055 | (/builds/slave/test/build/application/firefox/firefox:19162): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:05:49 INFO - PID 19055 | 09:05:49 INFO - PID 19055 | __metrics Screen width/height:1600/1200 09:05:49 INFO - PID 19055 | colorDepth:24 09:05:49 INFO - PID 19055 | Browser inner width/height: 1024/768 09:05:49 INFO - PID 19055 | __metrics 09:05:59 INFO - PID 19055 | RSS: Main: 165289984 09:05:59 INFO - PID 19055 | 09:06:01 INFO - PID 19055 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37198/tests/kraken/driver.html?testName=audio-beat-detection) 09:06:02 INFO - PID 19055 | RSS: Main: 170516480 09:06:02 INFO - PID 19055 | 09:06:05 INFO - PID 19055 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37198/tests/kraken/driver.html?testName=audio-dft) 09:06:06 INFO - PID 19055 | RSS: Main: 172998656 09:06:06 INFO - PID 19055 | 09:06:08 INFO - PID 19055 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37198/tests/kraken/driver.html?testName=audio-fft) 09:06:09 INFO - PID 19055 | RSS: Main: 165498880 09:06:09 INFO - PID 19055 | 09:06:11 INFO - PID 19055 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37198/tests/kraken/driver.html?testName=audio-oscillator) 09:06:12 INFO - PID 19055 | RSS: Main: 166559744 09:06:12 INFO - PID 19055 | 09:06:14 INFO - PID 19055 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37198/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:06:14 INFO - PID 19055 | RSS: Main: 166555648 09:06:14 INFO - PID 19055 | 09:06:17 INFO - PID 19055 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37198/tests/kraken/driver.html?testName=imaging-darkroom) 09:06:18 INFO - PID 19055 | RSS: Main: 166551552 09:06:18 INFO - PID 19055 | 09:06:22 INFO - PID 19055 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37198/tests/kraken/driver.html?testName=imaging-desaturate) 09:06:22 INFO - PID 19055 | RSS: Main: 168357888 09:06:22 INFO - PID 19055 | 09:06:25 INFO - PID 19055 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37198/tests/kraken/driver.html?testName=json-parse-financial) 09:06:26 INFO - PID 19055 | RSS: Main: 168579072 09:06:26 INFO - PID 19055 | 09:06:27 INFO - PID 19055 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37198/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:06:28 INFO - PID 19055 | RSS: Main: 168148992 09:06:28 INFO - PID 19055 | 09:06:29 INFO - PID 19055 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:06:30 INFO - PID 19055 | RSS: Main: 168472576 09:06:30 INFO - PID 19055 | 09:06:32 INFO - PID 19055 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:06:33 INFO - PID 19055 | RSS: Main: 168312832 09:06:33 INFO - PID 19055 | 09:06:35 INFO - PID 19055 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:06:36 INFO - PID 19055 | RSS: Main: 168312832 09:06:36 INFO - PID 19055 | 09:06:39 INFO - PID 19055 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:06:39 INFO - PID 19055 | RSS: Main: 168800256 09:06:39 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37198/tests/kraken/driver.html?testName=ai-astar) 09:06:41 INFO - PID 19055 | RSS: Main: 170594304 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | __start_tp_report 09:06:41 INFO - PID 19055 | _x_x_mozilla_page_load 09:06:41 INFO - PID 19055 | _x_x_mozilla_page_load_details 09:06:41 INFO - PID 19055 | |i|pagename|runs| 09:06:41 INFO - PID 19055 | |0;ai-astar;96;107;99;107;105;109;106;98;105;107 09:06:41 INFO - PID 19055 | |1;audio-beat-detection;143;114;146;171;121;142;142;118;167;119 09:06:41 INFO - PID 19055 | |2;audio-dft;164;163;161;163;161;163;161;161;166;170 09:06:41 INFO - PID 19055 | |3;audio-fft;73;73;73;163;74;73;72;73;174;73 09:06:41 INFO - PID 19055 | |4;audio-oscillator;79;79;132;79;78;79;133;80;80;128 09:06:41 INFO - PID 19055 | |5;imaging-gaussian-blur;113;114;113;114;115;114;113;114;114;114 09:06:41 INFO - PID 19055 | |6;imaging-darkroom;149;150;150;151;150;151;150;149;149;150 09:06:41 INFO - PID 19055 | |7;imaging-desaturate;94;98;94;95;94;95;94;94;94;93 09:06:41 INFO - PID 19055 | |8;json-parse-financial;48;46;46;45;45;46;46;46;46;45 09:06:41 INFO - PID 19055 | |9;json-stringify-tinderbox;51;51;52;51;52;52;51;53;50;51 09:06:41 INFO - PID 19055 | |10;stanford-crypto-aes;74;74;77;72;73;73;73;72;72;72 09:06:41 INFO - PID 19055 | |11;stanford-crypto-ccm;114;122;119;116;113;128;115;115;111;152 09:06:41 INFO - PID 19055 | |12;stanford-crypto-pbkdf2;171;174;172;169;178;173;175;171;164;170 09:06:41 INFO - PID 19055 | |13;stanford-crypto-sha256-iterative;62;67;64;66;61;62;65;61;60;60 09:06:41 INFO - PID 19055 | __end_tp_report 09:06:41 INFO - PID 19055 | __start_cc_report 09:06:41 INFO - PID 19055 | _x_x_mozilla_cycle_collect,867 09:06:41 INFO - PID 19055 | __end_cc_report 09:06:41 INFO - PID 19055 | __startTimestamp1503504401790__endTimestamp 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | ------- Summary: start ------- 09:06:41 INFO - PID 19055 | Number of tests: 14 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | [#0] ai-astar Cycles:10 Average:103.90 Median:108.00 stddev:4.51 (4.2%) stddev-sans-first:3.77 09:06:41 INFO - PID 19055 | Values: 96.0 107.0 99.0 107.0 105.0 109.0 106.0 98.0 105.0 107.0 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:142.50 stddev:20.21 (14.2%) stddev-sans-first:21.36 09:06:41 INFO - PID 19055 | Values: 143.0 114.0 146.0 171.0 121.0 142.0 142.0 118.0 167.0 119.0 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.87 (1.8%) stddev-sans-first:3.03 09:06:41 INFO - PID 19055 | Values: 164.0 163.0 161.0 163.0 161.0 163.0 161.0 161.0 166.0 170.0 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | [#3] audio-fft Cycles:10 Average:92.10 Median:73.00 stddev:40.35 (55.3%) stddev-sans-first:42.20 09:06:41 INFO - PID 19055 | Values: 73.0 73.0 73.0 163.0 74.0 73.0 72.0 73.0 174.0 73.0 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:25.09 (31.8%) stddev-sans-first:25.96 09:06:41 INFO - PID 19055 | Values: 79.0 79.0 132.0 79.0 78.0 79.0 133.0 80.0 80.0 128.0 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 09:06:41 INFO - PID 19055 | Values: 113.0 114.0 113.0 114.0 115.0 114.0 113.0 114.0 114.0 114.0 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 09:06:41 INFO - PID 19055 | Values: 149.0 150.0 150.0 151.0 150.0 151.0 150.0 149.0 149.0 150.0 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 09:06:41 INFO - PID 19055 | Values: 94.0 98.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 93.0 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | [#8] json-parse-financial Cycles:10 Average:45.90 Median:46.00 stddev:0.88 (1.9%) stddev-sans-first:0.50 09:06:41 INFO - PID 19055 | Values: 48.0 46.0 46.0 45.0 45.0 46.0 46.0 46.0 46.0 45.0 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | [#9] json-stringify-tinderbox Cycles:10 Average:51.40 Median:51.50 stddev:0.84 (1.6%) stddev-sans-first:0.88 09:06:41 INFO - PID 19055 | Values: 51.0 51.0 52.0 51.0 52.0 52.0 51.0 53.0 50.0 51.0 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:73.00 stddev:1.55 (2.1%) stddev-sans-first:1.62 09:06:41 INFO - PID 19055 | Values: 74.0 74.0 77.0 72.0 73.0 73.0 73.0 72.0 72.0 72.0 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:117.50 stddev:12.12 (10.3%) stddev-sans-first:12.63 09:06:41 INFO - PID 19055 | Values: 114.0 122.0 119.0 116.0 113.0 128.0 115.0 115.0 111.0 152.0 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:172.50 stddev:3.77 (2.2%) stddev-sans-first:3.99 09:06:41 INFO - PID 19055 | Values: 171.0 174.0 172.0 169.0 178.0 173.0 175.0 171.0 164.0 170.0 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:2.53 (4.0%) stddev-sans-first:2.67 09:06:41 INFO - PID 19055 | Values: 62.0 67.0 64.0 66.0 61.0 62.0 65.0 61.0 60.0 60.0 09:06:41 INFO - PID 19055 | -------- Summary: end -------- 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | 09:06:41 INFO - PID 19055 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 09:06:41 INFO - PID 19055 | 09:06:42 INFO - PID 19055 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:06:42 INFO - TEST-INFO | 19055: exit 0 09:06:42 INFO - TEST-OK | kraken | took 60551ms 09:06:42 INFO - SUITE-END | took 1171s 09:06:42 INFO - Completed test suite (00:19:31) 09:06:42 INFO - javascript benchmark 09:06:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8948.297748907507, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3855.8650447234354, 3866.052817059819, 3918.451416801647, 3921.490206273184, 3951.111000024993, 6118.296395914471, 6228.688565571721, 6240.032794916795, 6308.211473565804, 6318.557700960934, 6100.603460775058, 6196.039613859848, 6219.0, 6232.2521297444255, 6255.624662520252, 5603.0, 5617.4382561743905, 5627.2684551008315, 5645.717714114298, 5663.2637757091525, 5649.0396632572565, 5656.802011929583, 5664.20701101846, 5666.065099258617, 5736.2256095427, 5708.172315014342, 5715.571332150084, 5720.485156335929, 5733.913991290134, 5747.166660834177, 5614.326280846284, 5654.830355089333, 5712.171735098429, 5754.395788442237, 5766.452187042224, 5406.270153529302, 5477.178423236506, 5575.944240557583, 5580.91628625571, 5592.5805564582815, 6218.129461875341, 6224.377562243784, 6230.750769969196, 6340.953742632506, 6358.173437453148, 6721.227058888193, 6727.461803055744, 6735.966320168368, 6829.7609583664835, 6849.2808255132995, 6813.0, 6822.761203357908, 6837.247902730695, 6862.862742745117, 6909.447244220451, 6307.211598550181, 6379.298277189506, 6390.680465976682, 6390.904136438004, 6393.7762178324, 6926.8614627708175, 6928.237893831674, 7030.894536581955, 7032.507724459341, 7033.226345102034, 6567.573107747981, 6608.240052394036, 6649.60102393858, 6722.462203023844, 6798.184217893884, 6700.195976482853, 6754.763583274562, 6775.220849602359, 6801.829954251183, 6816.113905192294, 6679.2318883329035, 6699.363560461846, 6764.695588698521, 6775.119234499483, 6786.8642627148165, 6579.30917253691, 6628.23775265841, 6630.436412904957, 6679.799606011828, 6737.258901520829, 5024.171011783015, 5028.396592408934, 5029.698218106925, 5034.144195486703, 5077.416097148875, 4591.288350305708, 4697.882552936204, 4710.458297295855, 4721.0, 4725.5983241424865, 6144.4469997699525, 6146.78486252979, 6241.687915604201, 6246.125542424064, 6321.494280457644, 6738.157730283715, 6748.0, 6748.257691653914, 6752.08846805675, 6757.594544327258, 6106.236720409949, 6156.538259630545, 6157.291911430243, 6167.660778657217, 6243.344448832807, 5673.687947162863, 5678.14827775837, 5682.6306290091015, 5682.715864206856, 5685.431456854281, 7041.753538626226, 7043.894341584881, 7058.364747172676, 7150.570965742072, 7153.427725781925, 6610.603363798187, 6718.0, 6722.462203023844, 6764.492663050192, 6810.62541560219, 6871.14110736158, 6931.653417329214, 6973.267806880407, 7018.684159212949, 7051.048108505286, 6622.271550129578, 6674.83312917181, 6720.798376048726, 6749.3250674932115, 6754.966225168842, 6728.831779205559, 6753.3246675332075, 6830.419414349836, 6835.863282734417, 6856.897146542706, 6470.255920569007, 6473.48212143018, 6524.347565243438, 6530.314316996837, 6533.020046992989, 6476.028595710681, 6496.545241833026, 6529.314421985623, 6559.836004099936, 6567.835804104936, 6453.51598630114, 6466.4503517201565, 6552.868942621216, 6553.770618028346, 6556.803295901131, 6534.803955881332, 6536.150300460909, 6585.473162146921, 6605.0, 6623.966880165568, 6269.404406581368, 6365.7135428904885, 6374.4900407966325, 6445.903311450238, 6449.193850768654], "value": 6198.356799756233, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.8192270584531, 920.8250432417836, 947.6209516193521, 970.6893793985919, 972.7324985628951, 40253.59746402535, 41207.58792412075, 41247.175056498854, 41489.377659335136, 41618.58381416185, 38238.23523529528, 38345.616543834556, 38393.424098638476, 38431.423528647094, 38549.421758673576, 7140.607266600335, 7270.0, 7270.236625154335, 7272.745453909114, 7277.017602623631, 7133.750318738845, 7223.783286501413, 7226.458015648821, 7230.855382892339, 7755.72854950074, 7972.601369931509, 7995.320397766197, 8003.279704826565, 8020.879686804703, 8026.879596806052, 7816.296533312029, 7893.684252629888, 7905.565193914333, 7939.960300198491, 7946.721864734735, 7715.884261736079, 7791.415643826679, 7797.961010194969, 7799.103103143155, 7800.570968596725, 38813.41779873276, 39259.60740392588, 39262.60737392647, 39284.0, 39296.607033929584, 3569.7679650822615, 3585.1395665040463, 3597.6762091411897, 3598.6941110005682, 3613.421852503613, 30652.84673576618, 30782.692173078205, 30877.0, 30894.691053089406, 30937.535936960965, 5319.787208511655, 5331.147016477384, 5342.946570534284, 5348.277982472394, 5365.704886231256, 195853.0, 198100.0, 203544.0, 204799.0, 209366.0, 50923.0, 51269.743651281504, 51304.48695512997, 51423.7428812861, 51430.22854657183, 53709.73145134327, 53818.46181538213, 53883.46116538863, 53898.730506347216, 53899.73050134724, 16383.67232655364, 16451.42420015294, 16526.504204873872, 16568.17159142038, 16750.74873876893, 13660.180389176483, 13669.0, 13674.384652690653, 13679.179249245077, 13694.0, 14594.197319147548, 14617.90365722575, 14623.853761462462, 14722.190279534729, 14774.704505909822, 5631.690257035821, 5717.428257174332, 5721.227634269404, 5724.0, 5770.942290577041, 1035.5133087448887, 1047.0942634621, 1048.3709774135457, 1063.6489958313894, 1065.4779158212575, 24210.273691789276, 24284.514309713708, 24357.63463548048, 24425.877870610533, 24595.877020615142, 1119.6864877834219, 1134.920555561103, 1145.799485090106, 1162.7790719763218, 1164.9748221565137, 12733.808992865115, 12901.225926444444, 12922.483100676056, 12982.221066736027, 13013.154144980546, 276928.0, 281789.0, 283096.0, 283517.0, 283579.0, 61515.0, 61905.69047154736, 62061.37938620646, 62324.688376557824, 62408.68795655993, 1459.2776575595149, 1492.9701405972037, 1501.8573235542606, 1513.9470118545798, 1517.8254500732558, 28259.717402825707, 28537.571936421387, 29081.709182908748, 29160.0, 29869.0, 54762.17856732073, 55033.449665502834, 55093.0, 55120.0, 55271.0, 243304.0, 245217.0, 246190.0, 246644.0, 246802.0, 37358.439623406215, 38661.42007869828, 39739.0, 39800.80099599483, 39824.80087599543, 47236.52763472459, 48881.5111848877, 48919.266211007576, 49287.50712492829, 49345.50654493409, 35636.0, 35689.1077723059, 35730.64269357273, 36578.45132322964, 36756.632433675324, 35564.466533001505, 35673.46489802603, 35742.0, 35782.82108589545, 35959.64040359563, 39958.200835982534, 40058.79970600245, 40229.597704022584, 40319.39520907247, 40367.0, 33995.0, 34265.0, 34271.0, 34541.30917381689, 34789.65210347864, 25449.236522904343, 25542.616860747476, 25686.213817135886, 26292.73707262903, 26449.735502645497], "value": 18375.363543944943, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.3664300947453, 587.239524815364, 594.3165359836188, 598.8083813179782, 599.313785715356, 21345.25291614794, 22234.88882555587, 23126.88436557817, 23129.884350578224, 23146.88426557867, 24843.50312993739, 25227.747722522814, 25429.364265893317, 25462.108826191088, 25465.745342546616, 6385.936140638604, 6504.284528701839, 6511.120998665167, 6511.674416279191, 6520.250171230298, 5808.854778630526, 6147.862645410613, 6223.564350495444, 6230.750769969219, 6295.150154729099, 6187.845303867417, 6220.066989951521, 6247.15663385444, 6249.406306400907, 6256.0, 6148.600340977822, 6193.102000209944, 6221.688915554227, 6250.562460627758, 6258.749650013994, 5810.7385167667135, 5834.095715164156, 5847.736851841677, 5849.2103566018895, 5887.646741195542, 28365.858170709016, 29459.263518411997, 29722.0, 29843.850780745957, 29973.70026299731, 2274.9658755118685, 2305.7348404933477, 2306.2504685977124, 2306.550222706573, 2307.3308740465245, 19809.0, 20488.38534843957, 20523.281685141097, 20529.79470205294, 20551.075201615964, 2369.218158007853, 2442.7801497865275, 2484.291976786607, 2522.672052633164, 2546.0, 152903.0, 155575.22212388978, 155666.0, 155754.22122889425, 156460.0, 14384.35270412834, 15430.0, 15706.528804135894, 15725.606859828596, 15884.841151588567, 24787.25638230856, 24794.5041099177, 24802.25593232206, 24822.255332340057, 24852.37869053288, 10368.896311036944, 10390.740231494274, 10438.843417348595, 10450.581976720847, 10674.146068314516, 8754.781130471789, 9104.635814567344, 9569.425834449956, 9633.614655413705, 9742.659006934724, 9004.279657627374, 9556.187724043395, 9659.517024148765, 9687.70936871895, 9884.406935583887, 2741.7943654226015, 2749.3539018330675, 2767.114523352548, 2799.90200342987, 2806.593044008607, 993.7118235711563, 1009.9747506312254, 1015.7359086637528, 1020.8468729690458, 1024.0527512051324, 20228.494287642927, 20580.691289630668, 20606.0, 20825.479363015744, 21163.15347386118, 1044.5612842606124, 1075.424647813416, 1100.757833276678, 1101.1796211822243, 1106.115107913666, 11059.668209953714, 11480.311181329147, 11531.019863311712, 11578.47896844644, 11618.199318747555, 601974.0, 608021.0, 615145.0, 617312.0, 622294.0, 127117.36441317735, 132483.0, 132684.3365783165, 135674.0, 136387.31806340904, 1284.569669160823, 1319.973600527984, 1346.9326533673473, 1350.3923234544495, 1360.9183448993092, 21966.231181908555, 22275.66586501236, 22816.885915570318, 23129.306120816404, 24151.879240603685, 65033.67483162554, 65461.67269163624, 67456.325436745, 67645.66177169082, 68349.31650683629, 84480.57759711162, 84897.57551212204, 85377.0, 86687.13312867042, 88042.55978720065, 22385.44036399103, 22977.50646208058, 23031.769682302962, 23063.88468057649, 23123.537529249657, 24653.38366540851, 24712.752872471763, 24823.0, 24946.62580061264, 24981.75018249794, 19537.316193933144, 19953.900230498755, 20087.096080676696, 20088.096035678136, 20132.597348052663, 17891.552711182325, 18004.18981145878, 18049.458516244533, 18138.54653633617, 18209.271629134688, 20058.799412006276, 20341.27099196585, 20411.285605003755, 20453.2841350552, 20525.48686282795, 21660.783392165875, 22059.0, 22180.778192217873, 22280.77719222787, 22424.327270181922, 19526.121324540145, 19861.702074469184, 19889.303874364326, 20107.195712171935, 20146.899265504166], "value": 12949.411290257553, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.9312534373282, 1411.8870490360773, 1425.5295752401705, 1440.4958264607383, 1443.3504922784743, 15636.35818239084, 16210.918945405256, 16296.83703162968, 16311.510654680349, 16311.510654680364, 16520.339186432557, 16809.83190168098, 16820.663586728257, 16821.747673784874, 16826.915865420655, 2627.842329460229, 2723.6595425571804, 2784.8050636455455, 2822.1533539937936, 2822.717728227171, 2773.3066733316673, 2808.9016884409048, 2809.1712944681267, 2811.803173777826, 2813.395120049189, 2728.7271272872754, 2743.341598016472, 2783.067672329772, 2787.28924124348, 2791.3719413131985, 2669.706332303445, 2690.8116431849876, 2705.053231369015, 2716.891324347024, 2718.374773802017, 2715.253305341047, 2735.2341344423594, 2743.9451210975667, 2746.0114358830806, 2748.2991837081618, 15726.606834829221, 15792.0, 15925.203739812963, 15928.362865485367, 15928.681426371408, 8210.096889342167, 8399.37004724642, 8440.071592124861, 8441.198086181803, 8445.873311900326, 5397.46025397461, 5542.0, 5642.097264437671, 5744.8851022979725, 5762.394948530386, 1981.5442448236986, 1990.2536548794203, 1998.7301714268533, 1999.3901859932714, 2060.3406909788873, 28159.577606335923, 28421.57367639487, 28428.431431371257, 28439.85780071107, 28467.145985620256, 7140.642967851587, 7247.20280769115, 7261.8547629047125, 7302.56184628924, 7365.189829118793, 18742.0, 18747.718784218247, 18764.0, 18766.437006889813, 18774.436766897015, 8314.501129932223, 8458.323334133254, 8483.787905302293, 8486.151384861589, 8493.745187644381, 7437.590932498656, 7575.621218939031, 7607.733729319447, 7617.352525035434, 7682.201251892116, 5365.7585408656705, 5570.554355651539, 5584.944150558524, 5604.85987850307, 5633.69014704187, 1629.120275051459, 1634.6240364716182, 1637.4596383193518, 1649.496903444461, 1668.8414600612923, 867.1328671328671, 898.5462341517492, 909.3495306019553, 911.4667919267171, 915.4827522449795, 7781.144074151839, 7798.064232292161, 7821.882671759929, 7831.295183433518, 7863.685452581833, 740.6666999850089, 742.8922806193071, 758.1887380502809, 762.6911101004102, 769.4267770510893, 4949.802007919715, 5330.813421530228, 5406.59450541211, 5492.5331346835965, 5592.692401917852, 23025.078996840275, 23773.0, 23783.52432951331, 23858.52282954331, 23985.52028959446, 22130.114795408324, 23081.192158274716, 23094.98760987814, 23267.650985235236, 23433.41416464568, 12324.938375308066, 12438.81341779874, 12589.874101259053, 12606.369681515887, 12617.495300188073, 9733.561989710339, 9884.209263259067, 10006.44964526958, 10020.799584008133, 10093.697189084045, 19851.30520431778, 20675.68986465174, 20683.896580517605, 20811.687824682944, 20920.0, 20174.0, 20640.79359206389, 20680.276190333265, 21087.578248435253, 21418.250361237282, 12853.742925141632, 13239.66900827487, 13244.735105297646, 13276.0, 13282.269475178959, 14735.92632036833, 14844.554663360117, 14877.40490380416, 15046.774298385752, 15074.773878392052, 11363.204575679623, 11517.884821151682, 11558.30650160993, 11675.941620291844, 11849.52601895949, 10949.178811589003, 11203.15976301797, 11350.94324528372, 11469.426528673699, 11549.36478493691, 10144.391336519833, 10787.352758834495, 10787.352758834495, 10798.244122911321, 10799.622013229813, 8181.222783835526, 8181.386396020203, 8219.95890020546, 8266.504009759434, 8281.461704989157, 7838.882416763639, 7947.960260198662, 7991.520508769492, 8008.519488830689, 8087.433879628369], "value": 7028.94334621142, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.6660270632208, 541.9268398766166, 556.5686592890511, 561.8650326340792, 563.5547917145452, 6119.632822030676, 6137.355577664348, 6142.1708069410615, 6161.568690191689, 6225.937740622592, 6043.788467403641, 6078.057901025348, 6098.725557349919, 6153.723082461289, 6167.568270221086, 5086.186210206368, 5087.364079490064, 5099.745012749367, 5109.412417571971, 5117.462666420028, 4861.489543597924, 4879.536444037811, 5077.213031980031, 5096.439391666913, 5113.312606839734, 4826.17954947658, 4859.392575928009, 4860.2466617674145, 4908.263760435928, 4961.330220420251, 4872.196087645534, 4906.165951788204, 4941.160002799515, 4950.727709975949, 4964.453910069889, 4376.978115109436, 4415.66882483815, 4465.218586747306, 4483.50681425043, 4495.145922274757, 5938.346781853993, 5958.225430693982, 6010.699465026775, 6038.63768173911, 6074.817755467343, 5692.31692196939, 5699.145128230757, 5742.368339482654, 5764.971175144139, 5771.653700777924, 6524.956007038851, 6544.247411547685, 6597.208334999783, 6610.867782644368, 6613.173353330833, 4930.556249937487, 4931.3835770528685, 4945.876353091202, 4954.108260513106, 4975.353204083446, 6569.770058047945, 6577.769778057745, 6655.670515319599, 6717.63053032083, 6779.830504237384, 4972.950270497248, 4998.950010499849, 5027.039454612704, 5034.647574669812, 5054.671446355975, 5097.668651537638, 5100.158473851773, 5119.436861945183, 5120.48795120485, 5146.87132821675, 5627.634203776742, 5656.830295091154, 5664.433556644385, 5672.546196304285, 5718.656880587178, 6431.228252609717, 6460.257070436866, 6509.2750421138435, 6536.542442029012, 6553.475721942234, 1785.276962830056, 1788.9105544722972, 1798.2357498063532, 1802.585405356749, 1811.166863242923, 1170.7014711248578, 1240.4108048676987, 1244.8319476870506, 1249.3815561297035, 1254.5483625894672, 6093.329733729286, 6134.0, 6222.906656400158, 6228.47058000066, 6249.281332646804, 6573.342665733484, 6613.537052406382, 6688.598684078874, 6738.797836064828, 6774.593524388552, 6134.5092392608485, 6136.140940268366, 6170.691465426711, 6178.135061091451, 6193.4425901669065, 3505.895642872487, 3519.63043880394, 3520.4543295789194, 3526.5944416392445, 3553.200529880756, 6570.671466426659, 6776.42400395962, 6991.30086991307, 6994.965025174842, 7001.439884809305, 6637.369449902251, 6701.262861085277, 6706.5640733352175, 6722.899156512656, 6771.747226763065, 6753.15585551806, 6820.829479263058, 6862.965685171642, 6896.551724137858, 6941.930580694229, 6461.935380646133, 6505.967470162619, 6541.574797638138, 6570.47436205112, 6667.733290668513, 6471.741130354733, 6574.53978221539, 6582.670866456562, 6610.3720146586, 6630.088247933742, 6899.17209934811, 6913.688884000333, 6959.26927672587, 6968.163820341591, 6998.580085194701, 5077.619178561548, 5096.439391666988, 5099.719515426687, 5101.336826212569, 5102.4642412546145, 6512.706928188148, 6589.715005573867, 6611.206655201407, 6647.867042659216, 6697.229818570732, 6344.619322840645, 6390.648514331757, 6410.1987251593555, 6435.742570297136, 6470.611763294218, 6358.332375100733, 6404.487640988803, 6474.482041436768, 6518.608883467007, 6519.152510173647, 6218.409251121137, 6346.587471814318, 6369.293050453446, 6378.330275321025, 6447.548671592944, 6430.292667806444, 6467.547271690936, 6497.512686548623, 6518.087467754423, 6574.704138313883, 6309.936900630935, 6342.0, 6350.650714210763, 6355.936440635534, 6432.388923052303], "value": 5089.448806544492, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [960.1071003966308, 964.0744884910486, 985.5909797434065, 992.1665800727387, 994.4083270454078, 19341.806581934175, 19366.99999999998, 19585.118669659863, 19589.314373996913, 20551.897240513816, 20742.48143796406, 21168.788312116874, 21264.8936755316, 21296.254631087915, 21305.0, 1048.6696690542474, 1059.6662051453807, 1063.0485715284815, 1064.8668916385452, 1066.786642671465, 1048.8426735989585, 1069.8662667166604, 1070.812607793637, 1075.537518866887, 1090.1061129873508, 1139.0545846947055, 1139.5840518210834, 1141.1384404774383, 1141.8058929981883, 1142.5087212498622, 1120.787050460418, 1127.1039523578775, 1127.667338135252, 1127.6729748373002, 1128.6049882541167, 829.0010537302536, 830.2776584371635, 830.4892491117979, 830.5349004557468, 831.301706566487, 17358.65282694339, 17583.472495825146, 17608.383706570337, 18375.540611484685, 20683.689744653842, 22058.0, 22190.334289971328, 22266.443338916495, 22741.772582274298, 22749.772502275096, 15554.688906221812, 15996.0, 16120.193990300555, 16131.516054518266, 16197.02817830934, 3890.1247219375696, 3920.313945059603, 3920.9607903920883, 3923.058465968176, 3923.293807114718, 144137.27931360382, 145145.274273629, 145276.0, 145277.0, 145522.26155457075, 16582.917085414494, 16855.0, 16901.577460563585, 16983.320667173422, 16991.40530081441, 32675.509867352008, 33385.66614333874, 33456.665433345355, 33561.83219083938, 33648.0, 8647.697330593399, 8827.16141966512, 8834.116588341114, 8864.157904999014, 8884.555772211364, 4255.680823938217, 4317.460317460317, 4333.458317710286, 4335.804888780012, 4337.110892267077, 5684.77260909559, 5754.309482862083, 5760.222369979999, 5790.565707571949, 5815.563832712563, 1084.69628504019, 1107.429673718036, 1110.3227031510771, 1121.820508718601, 1125.454154734953, 690.6063543779998, 707.2715103443359, 707.8002785278903, 718.683779137178, 722.2777222777223, 11994.760104797855, 12003.1597788154, 12103.455344509519, 12180.147389682637, 12499.125061245808, 693.0782059860373, 701.8561194955022, 711.210556282526, 725.8512005039059, 726.0307489501469, 5530.198121272393, 5605.5515558756015, 5674.886502270014, 5707.001274776898, 5755.107958266475, 128033.0, 131770.0, 132755.0, 135257.0, 135477.0, 117478.0, 117532.0, 118746.0, 119285.0, 121614.0, 101071.49464252779, 101353.49323253483, 103048.0, 103884.48057759662, 104577.0, 10374.962503749564, 10747.301425407324, 10809.459527023775, 10856.131509479064, 11139.05318047975, 49787.0, 49963.0, 51052.74473627608, 51216.487835122665, 51367.229491558406, 62700.372996269456, 63451.0, 63535.0, 64041.35958640354, 64619.353806463216, 15943.282552285407, 16122.596935076717, 16125.838741612903, 16136.354545818505, 16144.838551614803, 23096.538069238184, 23528.529429411657, 23720.40698982539, 24106.758932411154, 24450.388740281636, 21278.255261065788, 21425.0, 21515.246966356102, 21678.132874685467, 21886.45283867916, 18096.72854907204, 18231.726524102414, 18248.0, 18387.0, 18411.72382414238, 19106.522336941132, 20033.198672052953, 20264.696029559862, 21453.89273053625, 21674.34976950694, 13687.247201404018, 14756.852431475978, 14937.77593336079, 15342.693146137239, 15678.843211567739, 15846.207689615703, 16052.277647505656, 16294.022358658518, 16427.260773265472, 16766.66466670684], "value": 9729.520640907973, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1476.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 107.0, 99.0, 107.0, 105.0, 109.0, 106.0, 98.0, 105.0, 107.0], "value": 103.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 114.0, 146.0, 171.0, 121.0, 142.0, 142.0, 118.0, 167.0, 119.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 161.0, 163.0, 161.0, 163.0, 161.0, 161.0, 166.0, 170.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 163.0, 74.0, 73.0, 72.0, 73.0, 174.0, 73.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 132.0, 79.0, 78.0, 79.0, 133.0, 80.0, 80.0, 128.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 151.0, 150.0, 151.0, 150.0, 149.0, 149.0, 150.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 93.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 46.0, 46.0, 45.0, 45.0, 46.0, 46.0, 46.0, 46.0, 45.0], "value": 45.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 51.0, 52.0, 52.0, 51.0, 53.0, 50.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 72.0, 73.0, 73.0, 73.0, 72.0, 72.0, 72.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 122.0, 119.0, 116.0, 113.0, 128.0, 115.0, 115.0, 111.0, 152.0], "value": 120.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 172.0, 169.0, 178.0, 173.0, 175.0, 171.0, 164.0, 170.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 67.0, 64.0, 66.0, 61.0, 62.0, 65.0, 61.0, 60.0, 60.0], "value": 62.8, "unit": "score"}]}]} 09:06:43 INFO - Return code: 0 09:06:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:06:43 INFO - # TBPL SUCCESS # 09:06:43 INFO - Running post-action listener: _package_coverage_data 09:06:43 INFO - Running post-action listener: _resource_record_post_action 09:06:43 INFO - [mozharness: 2017-08-23 16:06:43.082451Z] Finished run-tests step (success) 09:06:43 INFO - Running post-run listener: _resource_record_post_run 09:06:43 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 434380800; Read time: 444; Write time: 358176 09:06:43 INFO - TinderboxPrint: CPU usage
13.1% 09:06:43 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 444 09:06:43 INFO - TinderboxPrint: I/O write bytes / time
434,380,800 / 358,176 09:06:43 INFO - TinderboxPrint: CPU idle
8,244.9 (86.9%) 09:06:43 INFO - TinderboxPrint: CPU user
1,189.7 (12.5%) 09:06:43 INFO - TinderboxPrint: Swap in / out
0 / 0 09:06:43 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 117407744; Read time: 36; Write time: 128964 09:06:43 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:06:43 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 316973056; Read time: 408; Write time: 229212 09:06:43 INFO - Running post-run listener: _upload_blobber_files 09:06:43 INFO - Blob upload gear active. 09:06:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:06:43 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 09:06:43 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'] 09:06:43 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 09:06:44 INFO - (blobuploader) - INFO - Open directory for files ... 09:06:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:06:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:06:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:47 INFO - (blobuploader) - INFO - Done attempting. 09:06:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:06:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:06:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:48 INFO - (blobuploader) - INFO - Done attempting. 09:06:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:06:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:06:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:49 INFO - (blobuploader) - INFO - Done attempting. 09:06:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:06:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:06:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:50 INFO - (blobuploader) - INFO - Done attempting. 09:06:50 INFO - (blobuploader) - INFO - Iteration through files over. 09:06:50 INFO - Return code: 0 09:06:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:06:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:06:50 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b58958f3dac89f68928bbb579fd1286ebba01ba45053776b00442fd0a63263e394c28e2f779018c7f5efeeff5629e8c71a9625f88b979b7577fc5c5e35cc83c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5f670fc90473722a232ff0aa49cfe1f0b4c192eb5e2183839f5aede2f478ad24d84c02cdec68db04456b94ca3a1e4c53b41bcd112e894b1c69e3c7bf06b548a", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d67a0479b92a7e29f597689750ab8fb168677bdd82aafde8ec714e35e3c97a0e6da59c683aa71069bcf1bf60202c3ad72d5d8812393c57e5e4f38911a6845c9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67e679ffd211369f00855a6fa989c7a0ff2faac8ca3f4e5e971ed6d28797f28291ba79262251ed0e6a1f91142289bc2fe08c333bf365e7c40c2c9239ff26a429"} 09:06:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:06:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:06:50 INFO - Contents: 09:06:50 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b58958f3dac89f68928bbb579fd1286ebba01ba45053776b00442fd0a63263e394c28e2f779018c7f5efeeff5629e8c71a9625f88b979b7577fc5c5e35cc83c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5f670fc90473722a232ff0aa49cfe1f0b4c192eb5e2183839f5aede2f478ad24d84c02cdec68db04456b94ca3a1e4c53b41bcd112e894b1c69e3c7bf06b548a", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d67a0479b92a7e29f597689750ab8fb168677bdd82aafde8ec714e35e3c97a0e6da59c683aa71069bcf1bf60202c3ad72d5d8812393c57e5e4f38911a6845c9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67e679ffd211369f00855a6fa989c7a0ff2faac8ca3f4e5e971ed6d28797f28291ba79262251ed0e6a1f91142289bc2fe08c333bf365e7c40c2c9239ff26a429"} 09:06:50 INFO - Running post-run listener: copy_logs_to_upload_dir 09:06:50 INFO - Copying logs to upload dir... 09:06:50 INFO - mkdir: /builds/slave/test/build/upload/logs 09:06:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.600155 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-23 09:06:50.296814) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 09:06:50.304479) ========= 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=eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b58958f3dac89f68928bbb579fd1286ebba01ba45053776b00442fd0a63263e394c28e2f779018c7f5efeeff5629e8c71a9625f88b979b7577fc5c5e35cc83c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5f670fc90473722a232ff0aa49cfe1f0b4c192eb5e2183839f5aede2f478ad24d84c02cdec68db04456b94ca3a1e4c53b41bcd112e894b1c69e3c7bf06b548a", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d67a0479b92a7e29f597689750ab8fb168677bdd82aafde8ec714e35e3c97a0e6da59c683aa71069bcf1bf60202c3ad72d5d8812393c57e5e4f38911a6845c9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67e679ffd211369f00855a6fa989c7a0ff2faac8ca3f4e5e971ed6d28797f28291ba79262251ed0e6a1f91142289bc2fe08c333bf365e7c40c2c9239ff26a429"} build_url:https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/DHoxQ2R4S7S_LLlUuf292w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b58958f3dac89f68928bbb579fd1286ebba01ba45053776b00442fd0a63263e394c28e2f779018c7f5efeeff5629e8c71a9625f88b979b7577fc5c5e35cc83c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5f670fc90473722a232ff0aa49cfe1f0b4c192eb5e2183839f5aede2f478ad24d84c02cdec68db04456b94ca3a1e4c53b41bcd112e894b1c69e3c7bf06b548a", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d67a0479b92a7e29f597689750ab8fb168677bdd82aafde8ec714e35e3c97a0e6da59c683aa71069bcf1bf60202c3ad72d5d8812393c57e5e4f38911a6845c9", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67e679ffd211369f00855a6fa989c7a0ff2faac8ca3f4e5e971ed6d28797f28291ba79262251ed0e6a1f91142289bc2fe08c333bf365e7c40c2c9239ff26a429"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 09:06:50.333564) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 09:06:50.333893) ========= 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=eca2ab57546de7b41f256b19000001ef-1503503159.733268-1347311762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 09:06:50.413674) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 09:06:50.413949) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 09:06:50.417219) ========= ========= Total master_lag: 0.40 =========