builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1503354232.99 results: success (0) revision: c7570eb46382ee56d081e549b484341f400c864b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 15:23:52.994391) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 15:23:52.994799) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 15:23:52.995076) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 15:23:53.042432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 15:23:53.042725) ========= 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=836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-21 15:23:53-- 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% 62.8M=0s 2017-08-21 15:23:53 (62.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088894 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 15:23:53.208568) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 15:23:53.208833) ========= 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=836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015674 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 15:23:53.272318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 15:23:53.272602) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c7570eb46382ee56d081e549b484341f400c864b --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 c7570eb46382ee56d081e549b484341f400c864b --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=836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-21 15:23:53,647 truncating revision to first 12 chars 2017-08-21 15:23:53,647 Setting DEBUG logging. 2017-08-21 15:23:53,647 attempt 1/10 2017-08-21 15:23:53,647 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c7570eb46382?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-21 15:23:53,944 unpacking tar archive at: mozilla-central-c7570eb46382/testing/mozharness/ program finished with exit code 0 elapsedTime=0.719618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 15:23:54.010570) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 15:23:54.010864) ========= script_repo_revision: c7570eb46382ee56d081e549b484341f400c864b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 15:23:54.011252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 15:23:54.011509) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 15:23:54.026293) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-21 15:23:54.026637) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:23:54 INFO - MultiFileLogger online at 20170821 15:23:54 in /builds/slave/test 15:23:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:23:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:23:54 INFO - {'append_to_log': False, 15:23:54 INFO - 'base_work_dir': '/builds/slave/test', 15:23:54 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:23:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:23:54 INFO - 'branch': 'Firefox-Non-PGO', 15:23:54 INFO - 'buildbot_json_path': 'buildprops.json', 15:23:54 INFO - 'code_coverage': False, 15:23:54 INFO - 'config_files': ('talos/linux_config.py',), 15:23:54 INFO - 'default_actions': ('clobber', 15:23:54 INFO - 'read-buildbot-config', 15:23:54 INFO - 'download-and-extract', 15:23:54 INFO - 'populate-webroot', 15:23:54 INFO - 'create-virtualenv', 15:23:54 INFO - 'install', 15:23:54 INFO - 'setup-mitmproxy', 15:23:54 INFO - 'run-tests'), 15:23:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:23:54 INFO - 'disable_ccov_upload': False, 15:23:54 INFO - 'download_minidump_stackwalk': True, 15:23:54 INFO - 'download_symbols': 'ondemand', 15:23:54 INFO - 'enable_stylo': False, 15:23:54 INFO - 'enable_webrender': False, 15:23:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:23:54 INFO - 'tooltool.py': '/tools/tooltool.py', 15:23:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:23:54 INFO - '/tools/misc-python/virtualenv.py')}, 15:23:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:23:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:23:54 INFO - 'gecko_profile': False, 15:23:54 INFO - 'gecko_profile_interval': 0, 15:23:54 INFO - 'installer_path': 'installer.exe', 15:23:54 INFO - 'log_level': 'info', 15:23:54 INFO - 'log_name': 'talos', 15:23:54 INFO - 'log_to_console': True, 15:23:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:23:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:23:54 INFO - 'opt_config_files': (), 15:23:54 INFO - 'pip_index': False, 15:23:54 INFO - 'suite': 'dromaeojs-e10s', 15:23:54 INFO - 'system_bits': '32', 15:23:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:23:54 INFO - 'title': 'talos-linux64-ix-028', 15:23:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:23:54 INFO - 'use_talos_json': True, 15:23:54 INFO - 'verify': 'False', 15:23:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:23:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:23:54 INFO - 'work_dir': 'build'} 15:23:54 INFO - [mozharness: 2017-08-21 22:23:54.540662Z] Running clobber step. 15:23:54 INFO - Running pre-action listener: _resource_record_pre_action 15:23:54 INFO - Running main action method: clobber 15:23:54 INFO - rmtree: /builds/slave/test/build 15:23:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:23:55 INFO - Running post-action listener: _resource_record_post_action 15:23:55 INFO - [mozharness: 2017-08-21 22:23:55.563150Z] Finished clobber step (success) 15:23:55 INFO - [mozharness: 2017-08-21 22:23:55.563246Z] Running read-buildbot-config step. 15:23:55 INFO - Running pre-action listener: _resource_record_pre_action 15:23:55 INFO - Running main action method: read_buildbot_config 15:23:55 INFO - Using buildbot properties: 15:23:55 INFO - { 15:23:55 INFO - "project": "", 15:23:55 INFO - "product": "firefox", 15:23:55 INFO - "who": "kwierso@gmail.com", 15:23:55 INFO - "installer_path": "public/build/target.tar.bz2", 15:23:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:23:55 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:23:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:23:55 INFO - "stage_platform": "linux64", 15:23:55 INFO - "basedir": "/builds/slave/test", 15:23:55 INFO - "buildnumber": 782, 15:23:55 INFO - "platform": "ubuntu64_hw", 15:23:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:23:55 INFO - "slavebuilddir": "test", 15:23:55 INFO - "taskId": "Bd8CnOMdQpeTAuVxIGTKrg", 15:23:55 INFO - "branch": "mozilla-central", 15:23:55 INFO - "script_repo_revision": "production", 15:23:55 INFO - "revision": "c7570eb46382ee56d081e549b484341f400c864b", 15:23:55 INFO - "slavename": "talos-linux64-ix-028", 15:23:55 INFO - "repo_path": "mozilla-central" 15:23:55 INFO - } 15:23:55 INFO - Finding installer, test and symbols from parent task. 15:23:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bd8CnOMdQpeTAuVxIGTKrg'}, attempt #1 15:23:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Bd8CnOMdQpeTAuVxIGTKrg'}, attempt #1 15:23:56 INFO - Task dependencies: XiGfkjnVRXmFRNo1aAXTHw 15:23:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw'}, attempt #1 15:23:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.tar.bz2 15:23:56 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.test_packages.json 15:23:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.crashreporter-symbols.zip 15:23:56 INFO - Running post-action listener: _resource_record_post_action 15:23:56 INFO - [mozharness: 2017-08-21 22:23:56.909084Z] Finished read-buildbot-config step (success) 15:23:56 INFO - [mozharness: 2017-08-21 22:23:56.909298Z] Running download-and-extract step. 15:23:56 INFO - Running pre-action listener: _resource_record_pre_action 15:23:56 INFO - Running main action method: download_and_extract 15:23:56 INFO - mkdir: /builds/slave/test/build/tests 15:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:56 INFO - trying https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.test_packages.json 15:23:56 INFO - Downloading https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:23:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:23:57 INFO - Downloaded 989 bytes. 15:23:57 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:23:57 INFO - Using the following test package requirements: 15:23:57 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:23:57 INFO - u'common': [u'target.common.tests.zip'], 15:23:57 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:23:57 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:23:57 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:23:57 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:23:57 INFO - u'mozbase': [u'target.common.tests.zip'], 15:23:57 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:23:57 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:23:57 INFO - u'web-platform': [u'target.common.tests.zip', 15:23:57 INFO - u'target.web-platform.tests.tar.gz'], 15:23:57 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:23:57 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:23:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.common.tests.zip 15:23:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:23:57 INFO - Fetch https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.common.tests.zip into memory 15:24:00 INFO - Content-Length response header: 54005877 15:24:00 INFO - Bytes received: 54005877 15:24:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:24:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.common.tests.zip 15:24:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:24:11 INFO - Fetch https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.common.tests.zip into memory 15:24:12 INFO - Content-Length response header: 54005877 15:24:12 INFO - Bytes received: 54005877 15:24:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.talos.tests.zip 15:24:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:24:24 INFO - Fetch https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.talos.tests.zip into memory 15:24:25 INFO - Content-Length response header: 14496256 15:24:25 INFO - Bytes received: 14496256 15:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:25 INFO - trying https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.tar.bz2 15:24:25 INFO - Downloading https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:24:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:24:28 INFO - Downloaded 62155945 bytes. 15:24:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.tar.bz2 15:24:28 INFO - mkdir: /builds/slave/test/properties 15:24:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:24:28 INFO - Writing to file /builds/slave/test/properties/build_url 15:24:28 INFO - Contents: 15:24:28 INFO - build_url:https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.tar.bz2 15:24:28 INFO - Running post-action listener: _resource_record_post_action 15:24:28 INFO - Running post-action listener: find_tests_for_verification 15:24:28 INFO - Running post-action listener: set_extra_try_arguments 15:24:28 INFO - [mozharness: 2017-08-21 22:24:28.425739Z] Finished download-and-extract step (success) 15:24:28 INFO - [mozharness: 2017-08-21 22:24:28.425965Z] Running populate-webroot step. 15:24:28 INFO - Running pre-action listener: _resource_record_pre_action 15:24:28 INFO - Running main action method: populate_webroot 15:24:28 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:24:28 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 15:24:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:24:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:24:28 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 15:24:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:24:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:24:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:28 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:24:28 INFO - 'talos_options': ['--stylo'], 15:24:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:24:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:24:28 INFO - 'tests': ['damp', 'tps']}, 15:24:28 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:24:28 INFO - 'talos_options': ['--stylo'], 15:24:28 INFO - 'tests': ['damp', 'tps']}, 15:24:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:24:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:24:28 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 15:24:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:24:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:24:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:24:28 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:24:28 INFO - 'talos_options': ['--stylo'], 15:24:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:24:28 INFO - 'other-e10s': {'tests': ['a11yr', 15:24:28 INFO - 'ts_paint', 15:24:28 INFO - 'tpaint', 15:24:28 INFO - 'sessionrestore', 15:24:28 INFO - 'sessionrestore_many_windows', 15:24:28 INFO - 'sessionrestore_no_auto_restore', 15:24:28 INFO - 'tabpaint']}, 15:24:28 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 15:24:28 INFO - 'tests': ['a11yr', 15:24:28 INFO - 'ts_paint', 15:24:28 INFO - 'tpaint', 15:24:28 INFO - 'sessionrestore', 15:24:28 INFO - 'sessionrestore_many_windows', 15:24:28 INFO - 'sessionrestore_no_auto_restore', 15:24:28 INFO - 'tabpaint']}, 15:24:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:24:28 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:24:28 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 15:24:28 INFO - 'tests': ['bloom_basic_singleton']}, 15:24:28 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 15:24:28 INFO - 'tests': ['bloom_basic']}, 15:24:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:24:28 INFO - 'tsvgr_opacity', 15:24:28 INFO - 'tart', 15:24:28 INFO - 'tscrollx', 15:24:28 INFO - 'tsvg_static']}, 15:24:28 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 15:24:28 INFO - 'tests': ['tsvgx', 15:24:28 INFO - 'tsvgr_opacity', 15:24:28 INFO - 'tart', 15:24:28 INFO - 'tscrollx', 15:24:28 INFO - 'tsvg_static']}, 15:24:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:24:28 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:24:28 INFO - 'talos_options': ['--stylo'], 15:24:28 INFO - 'tests': ['tp5o']}, 15:24:28 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:24:28 INFO - 'talos_options': ['--mitmproxy', 15:24:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:24:28 INFO - '--firstNonBlankPaint'], 15:24:28 INFO - 'tests': ['tp6_google', 15:24:28 INFO - 'tp6_youtube', 15:24:28 INFO - 'tp6_amazon', 15:24:28 INFO - 'tp6_facebook']}, 15:24:28 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:24:28 INFO - 'talos_options': ['--stylo', 15:24:28 INFO - '--mitmproxy', 15:24:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:24:28 INFO - '--firstNonBlankPaint'], 15:24:28 INFO - 'tests': ['tp6_google', 15:24:28 INFO - 'tp6_youtube', 15:24:28 INFO - 'tp6_amazon', 15:24:28 INFO - 'tp6_facebook']}, 15:24:28 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:24:28 INFO - 'talos_options': ['--stylo', 15:24:28 INFO - '--stylo-threads=1', 15:24:28 INFO - '--mitmproxy', 15:24:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:24:28 INFO - '--firstNonBlankPaint'], 15:24:28 INFO - 'tests': ['tp6_google', 15:24:28 INFO - 'tp6_youtube', 15:24:28 INFO - 'tp6_amazon', 15:24:28 INFO - 'tp6_facebook']}, 15:24:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:24:28 INFO - 'talos_options': ['--xperf_path', 15:24:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:28 INFO - 'tests': ['tp5n']}, 15:24:28 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:24:28 INFO - 'talos_options': ['--stylo', 15:24:28 INFO - '--xperf_path', 15:24:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:24:28 INFO - 'tests': ['tp5n']}}} 15:24:28 INFO - Running post-action listener: _resource_record_post_action 15:24:28 INFO - [mozharness: 2017-08-21 22:24:28.447809Z] Finished populate-webroot step (success) 15:24:28 INFO - [mozharness: 2017-08-21 22:24:28.447898Z] Running create-virtualenv step. 15:24:28 INFO - Running pre-action listener: _resource_record_pre_action 15:24:28 INFO - Running main action method: create_virtualenv 15:24:28 INFO - Creating virtualenv /builds/slave/test/build/venv 15:24:28 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 15:24:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:24:28 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:24:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:24:28 INFO - Using real prefix '/usr' 15:24:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:24:29 INFO - Installing distribute.............................................................................................................................................................................................done. 15:24:31 INFO - Installing pip.................done. 15:24:31 INFO - Return code: 0 15:24:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:24:31 INFO - Reading from file tmpfile_stdout 15:24:31 INFO - Output received: 15:24:31 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) 15:24:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:24: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')]} 15:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24: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')]} 15:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:31 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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6130>, '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 0xea7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea74c0>, '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': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:24:31 INFO - Using env: {'DISPLAY': ':0', 15:24:31 INFO - 'HOME': '/home/cltbld', 15:24:31 INFO - 'LANG': 'en_US.UTF-8', 15:24:31 INFO - 'LANGUAGE': 'en_US:en', 15:24:31 INFO - 'LOGNAME': 'cltbld', 15:24:31 INFO - 'MAIL': '/var/mail/cltbld', 15:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:31 INFO - 'MOZ_NO_REMOTE': '1', 15:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:31 INFO - 'NO_EM_RESTART': '1', 15:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:31 INFO - 'PWD': '/builds/slave/test', 15:24:31 INFO - 'SHELL': '/bin/bash', 15:24:31 INFO - 'SHLVL': '1', 15:24:31 INFO - 'TERM': 'linux', 15:24:31 INFO - 'TMOUT': '86400', 15:24:31 INFO - 'USER': 'cltbld', 15:24:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 15:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:31 INFO - '_': '/tools/buildbot/bin/python'} 15:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:31 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 15:24:31 INFO - Cleaning up... 15:24:31 INFO - Return code: 0 15:24:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:24: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')]} 15:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24: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')]} 15:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:31 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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6130>, '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 0xea7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea74c0>, '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': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:24:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:24:31 INFO - Using env: {'DISPLAY': ':0', 15:24:31 INFO - 'HOME': '/home/cltbld', 15:24:31 INFO - 'LANG': 'en_US.UTF-8', 15:24:31 INFO - 'LANGUAGE': 'en_US:en', 15:24:31 INFO - 'LOGNAME': 'cltbld', 15:24:31 INFO - 'MAIL': '/var/mail/cltbld', 15:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:31 INFO - 'MOZ_NO_REMOTE': '1', 15:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:31 INFO - 'NO_EM_RESTART': '1', 15:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:31 INFO - 'PWD': '/builds/slave/test', 15:24:31 INFO - 'SHELL': '/bin/bash', 15:24:31 INFO - 'SHLVL': '1', 15:24:31 INFO - 'TERM': 'linux', 15:24:31 INFO - 'TMOUT': '86400', 15:24:31 INFO - 'USER': 'cltbld', 15:24:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 15:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:31 INFO - '_': '/tools/buildbot/bin/python'} 15:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:31 INFO - Downloading/unpacking psutil>=3.1.1 15:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:24:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:32 INFO - Installing collected packages: psutil 15:24:32 INFO - Running setup.py install for psutil 15:24:32 INFO - building 'psutil._psutil_linux' extension 15:24:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:24:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:24:33 INFO - building 'psutil._psutil_posix' extension 15:24:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:24:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:24:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:24:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:24:33 INFO - Successfully installed psutil 15:24:33 INFO - Cleaning up... 15:24:33 INFO - Return code: 0 15:24:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:33 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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6130>, '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 0xea7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea74c0>, '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': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:24:33 INFO - Using env: {'DISPLAY': ':0', 15:24:33 INFO - 'HOME': '/home/cltbld', 15:24:33 INFO - 'LANG': 'en_US.UTF-8', 15:24:33 INFO - 'LANGUAGE': 'en_US:en', 15:24:33 INFO - 'LOGNAME': 'cltbld', 15:24:33 INFO - 'MAIL': '/var/mail/cltbld', 15:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:33 INFO - 'MOZ_NO_REMOTE': '1', 15:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:33 INFO - 'NO_EM_RESTART': '1', 15:24:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:33 INFO - 'PWD': '/builds/slave/test', 15:24:33 INFO - 'SHELL': '/bin/bash', 15:24:33 INFO - 'SHLVL': '1', 15:24:33 INFO - 'TERM': 'linux', 15:24:33 INFO - 'TMOUT': '86400', 15:24:33 INFO - 'USER': 'cltbld', 15:24:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 15:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:33 INFO - '_': '/tools/buildbot/bin/python'} 15:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:24:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:24:34 INFO - Installing collected packages: mozsystemmonitor 15:24:34 INFO - Running setup.py install for mozsystemmonitor 15:24:34 INFO - Successfully installed mozsystemmonitor 15:24:34 INFO - Cleaning up... 15:24:35 INFO - Return code: 0 15:24:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:24: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')]} 15:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24: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')]} 15:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24: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', '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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6130>, '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 0xea7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea74c0>, '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': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:24: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 jsonschema==2.5.1 15:24:35 INFO - Using env: {'DISPLAY': ':0', 15:24:35 INFO - 'HOME': '/home/cltbld', 15:24:35 INFO - 'LANG': 'en_US.UTF-8', 15:24:35 INFO - 'LANGUAGE': 'en_US:en', 15:24:35 INFO - 'LOGNAME': 'cltbld', 15:24:35 INFO - 'MAIL': '/var/mail/cltbld', 15:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:35 INFO - 'MOZ_NO_REMOTE': '1', 15:24:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:35 INFO - 'NO_EM_RESTART': '1', 15:24:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:35 INFO - 'PWD': '/builds/slave/test', 15:24:35 INFO - 'SHELL': '/bin/bash', 15:24:35 INFO - 'SHLVL': '1', 15:24:35 INFO - 'TERM': 'linux', 15:24:35 INFO - 'TMOUT': '86400', 15:24:35 INFO - 'USER': 'cltbld', 15:24:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 15:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:35 INFO - '_': '/tools/buildbot/bin/python'} 15:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:35 INFO - Downloading/unpacking jsonschema==2.5.1 15:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:24:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:24: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 15:24: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 15:24: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 15:24: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 15:24:36 INFO - Downloading functools32-3.2.3-2.tar.gz 15:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:24:36 INFO - warning: no files found matching '*.txt' 15:24:36 INFO - no previously-included directories found matching 'build' 15:24:36 INFO - no previously-included directories found matching 'dist' 15:24:36 INFO - no previously-included directories found matching '.git*' 15:24:36 INFO - Installing collected packages: jsonschema, functools32 15:24:36 INFO - Running setup.py install for functools32 15:24:36 INFO - warning: no files found matching '*.txt' 15:24:36 INFO - no previously-included directories found matching 'build' 15:24:36 INFO - no previously-included directories found matching 'dist' 15:24:36 INFO - no previously-included directories found matching '.git*' 15:24:36 INFO - Successfully installed jsonschema functools32 15:24:36 INFO - Cleaning up... 15:24:36 INFO - Return code: 0 15:24:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6130>, '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 0xea7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea74c0>, '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': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:24:36 INFO - Using env: {'DISPLAY': ':0', 15:24:36 INFO - 'HOME': '/home/cltbld', 15:24:36 INFO - 'LANG': 'en_US.UTF-8', 15:24:36 INFO - 'LANGUAGE': 'en_US:en', 15:24:36 INFO - 'LOGNAME': 'cltbld', 15:24:36 INFO - 'MAIL': '/var/mail/cltbld', 15:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:36 INFO - 'MOZ_NO_REMOTE': '1', 15:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:36 INFO - 'NO_EM_RESTART': '1', 15:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:36 INFO - 'PWD': '/builds/slave/test', 15:24:36 INFO - 'SHELL': '/bin/bash', 15:24:36 INFO - 'SHLVL': '1', 15:24:36 INFO - 'TERM': 'linux', 15:24:36 INFO - 'TMOUT': '86400', 15:24:36 INFO - 'USER': 'cltbld', 15:24:36 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 15:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:36 INFO - '_': '/tools/buildbot/bin/python'} 15:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:24:36 INFO - Cleaning up... 15:24:36 INFO - Return code: 0 15:24:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6130>, '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 0xea7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea74c0>, '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': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:24:36 INFO - Using env: {'DISPLAY': ':0', 15:24:36 INFO - 'HOME': '/home/cltbld', 15:24:36 INFO - 'LANG': 'en_US.UTF-8', 15:24:36 INFO - 'LANGUAGE': 'en_US:en', 15:24:36 INFO - 'LOGNAME': 'cltbld', 15:24:36 INFO - 'MAIL': '/var/mail/cltbld', 15:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:36 INFO - 'MOZ_NO_REMOTE': '1', 15:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:36 INFO - 'NO_EM_RESTART': '1', 15:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:36 INFO - 'PWD': '/builds/slave/test', 15:24:36 INFO - 'SHELL': '/bin/bash', 15:24:36 INFO - 'SHLVL': '1', 15:24:36 INFO - 'TERM': 'linux', 15:24:36 INFO - 'TMOUT': '86400', 15:24:36 INFO - 'USER': 'cltbld', 15:24:36 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 15:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:36 INFO - '_': '/tools/buildbot/bin/python'} 15:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:37 INFO - Downloading/unpacking blobuploader==1.2.4 15:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:38 INFO - Downloading blobuploader-1.2.4.tar.gz 15:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:24:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:24: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 15:24: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 15:24: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 15:24: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 15:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:24:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:24: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 15:24: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 15:24: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 15:24: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 15:24:38 INFO - Downloading docopt-0.6.1.tar.gz 15:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:24:38 INFO - Installing collected packages: blobuploader, requests, docopt 15:24:38 INFO - Running setup.py install for blobuploader 15:24:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:24:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:24:39 INFO - Running setup.py install for requests 15:24:39 INFO - Running setup.py install for docopt 15:24:39 INFO - Successfully installed blobuploader requests docopt 15:24:39 INFO - Cleaning up... 15:24:39 INFO - Return code: 0 15:24:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24: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')]} 15:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24: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')]} 15:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:39 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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6130>, '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 0xea7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea74c0>, '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': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:24:39 INFO - Using env: {'DISPLAY': ':0', 15:24:39 INFO - 'HOME': '/home/cltbld', 15:24:39 INFO - 'LANG': 'en_US.UTF-8', 15:24:39 INFO - 'LANGUAGE': 'en_US:en', 15:24:39 INFO - 'LOGNAME': 'cltbld', 15:24:39 INFO - 'MAIL': '/var/mail/cltbld', 15:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:39 INFO - 'MOZ_NO_REMOTE': '1', 15:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:39 INFO - 'NO_EM_RESTART': '1', 15:24:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:39 INFO - 'PWD': '/builds/slave/test', 15:24:39 INFO - 'SHELL': '/bin/bash', 15:24:39 INFO - 'SHLVL': '1', 15:24:39 INFO - 'TERM': 'linux', 15:24:39 INFO - 'TMOUT': '86400', 15:24:39 INFO - 'USER': 'cltbld', 15:24:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 15:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:39 INFO - '_': '/tools/buildbot/bin/python'} 15:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:39 INFO - Running setup.py (path:/tmp/pip-mYCifi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:39 INFO - Running setup.py (path:/tmp/pip-HNAS5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:39 INFO - Running setup.py (path:/tmp/pip-gq3clp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:39 INFO - Running setup.py (path:/tmp/pip-Aa3rvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:24:40 INFO - Running setup.py (path:/tmp/pip-UywnV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:24:40 INFO - Running setup.py (path:/tmp/pip-lYqi32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:24:40 INFO - Running setup.py (path:/tmp/pip-GMGG2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:24:40 INFO - Running setup.py (path:/tmp/pip-6rBAN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:24:40 INFO - Running setup.py (path:/tmp/pip-RVas0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:24:40 INFO - Running setup.py (path:/tmp/pip-Yt5i2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:24:40 INFO - Running setup.py (path:/tmp/pip-T5g9Am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:24:40 INFO - Running setup.py (path:/tmp/pip-FQkWuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:24:40 INFO - Running setup.py (path:/tmp/pip-Inzsle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:24:40 INFO - Running setup.py (path:/tmp/pip-ChsAh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:40 INFO - Running setup.py (path:/tmp/pip-BDokmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:40 INFO - Running setup.py (path:/tmp/pip-FsAL11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:40 INFO - Running setup.py (path:/tmp/pip-LgrVBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:24:40 INFO - Running setup.py install for manifestparser 15:24:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:24:41 INFO - Running setup.py install for mozcrash 15:24:41 INFO - Running setup.py install for mozdebug 15:24:41 INFO - Running setup.py install for mozdevice 15:24:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:24:41 INFO - Running setup.py install for mozfile 15:24:41 INFO - Running setup.py install for mozhttpd 15:24:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:24:41 INFO - Running setup.py install for mozinfo 15:24:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:24:41 INFO - Running setup.py install for mozInstall 15:24:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:24:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:24:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:24:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:24:41 INFO - Running setup.py install for mozleak 15:24:41 INFO - Running setup.py install for mozlog 15:24:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:24:42 INFO - Running setup.py install for moznetwork 15:24:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:24:42 INFO - Running setup.py install for mozprocess 15:24:42 INFO - Running setup.py install for mozprofile 15:24:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:24:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:24:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:24:42 INFO - Running setup.py install for mozrunner 15:24:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:24:42 INFO - Running setup.py install for mozscreenshot 15:24:42 INFO - Running setup.py install for moztest 15:24:42 INFO - Running setup.py install for mozversion 15:24:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:24:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:24:42 INFO - Cleaning up... 15:24:42 INFO - Return code: 0 15:24:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:42 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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6130>, '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 0xea7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea74c0>, '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': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:24:42 INFO - Using env: {'DISPLAY': ':0', 15:24:42 INFO - 'HOME': '/home/cltbld', 15:24:42 INFO - 'LANG': 'en_US.UTF-8', 15:24:42 INFO - 'LANGUAGE': 'en_US:en', 15:24:42 INFO - 'LOGNAME': 'cltbld', 15:24:42 INFO - 'MAIL': '/var/mail/cltbld', 15:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:42 INFO - 'MOZ_NO_REMOTE': '1', 15:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:42 INFO - 'NO_EM_RESTART': '1', 15:24:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:42 INFO - 'PWD': '/builds/slave/test', 15:24:42 INFO - 'SHELL': '/bin/bash', 15:24:42 INFO - 'SHLVL': '1', 15:24:42 INFO - 'TERM': 'linux', 15:24:42 INFO - 'TMOUT': '86400', 15:24:42 INFO - 'USER': 'cltbld', 15:24:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 15:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:42 INFO - '_': '/tools/buildbot/bin/python'} 15:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:42 INFO - Running setup.py (path:/tmp/pip-yk6yTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:43 INFO - Running setup.py (path:/tmp/pip-o_wsWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:43 INFO - Running setup.py (path:/tmp/pip-8IfUEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:43 INFO - Running setup.py (path:/tmp/pip-J5i8TC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:24:43 INFO - Running setup.py (path:/tmp/pip-kBccoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:24:43 INFO - Running setup.py (path:/tmp/pip-8T4VfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:24:43 INFO - Running setup.py (path:/tmp/pip-kmRUbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:24:43 INFO - Running setup.py (path:/tmp/pip-gWT6ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:24:43 INFO - Running setup.py (path:/tmp/pip-OJeuJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:24:43 INFO - Running setup.py (path:/tmp/pip-AN637s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:24:43 INFO - Running setup.py (path:/tmp/pip-Bl47Lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:24:43 INFO - Running setup.py (path:/tmp/pip-z8QOIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:24:43 INFO - Running setup.py (path:/tmp/pip-EuEiPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:24:43 INFO - Running setup.py (path:/tmp/pip-ywAvW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:44 INFO - Running setup.py (path:/tmp/pip-RsH3kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:44 INFO - Running setup.py (path:/tmp/pip-dd2o2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:44 INFO - Running setup.py (path:/tmp/pip-jlG7vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:24:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:45 INFO - Downloading blessings-1.6.tar.gz 15:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:24:45 INFO - Installing collected packages: blessings 15:24:45 INFO - Running setup.py install for blessings 15:24:45 INFO - Successfully installed blessings 15:24:45 INFO - Cleaning up... 15:24:45 INFO - Return code: 0 15:24:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:45 INFO - Reading from file tmpfile_stdout 15:24:45 INFO - Current package versions: 15:24:45 INFO - argparse == 1.2.1 15:24:45 INFO - blessings == 1.6 15:24:45 INFO - blobuploader == 1.2.4 15:24:45 INFO - docopt == 0.6.1 15:24:45 INFO - functools32 == 3.2.3-2 15:24:45 INFO - jsonschema == 2.5.1 15:24:45 INFO - manifestparser == 1.1 15:24:45 INFO - mozInstall == 1.13 15:24:45 INFO - mozcrash == 1.0 15:24:45 INFO - mozdebug == 0.1 15:24:45 INFO - mozdevice == 0.51 15:24:45 INFO - mozfile == 1.2 15:24:45 INFO - mozhttpd == 0.7 15:24:45 INFO - mozinfo == 0.10 15:24:45 INFO - mozleak == 0.1 15:24:45 INFO - mozlog == 3.5 15:24:45 INFO - moznetwork == 0.27 15:24:45 INFO - mozprocess == 0.25 15:24:45 INFO - mozprofile == 0.28 15:24:45 INFO - mozrunner == 6.13 15:24:45 INFO - mozscreenshot == 0.1 15:24:45 INFO - mozsystemmonitor == 0.3 15:24:45 INFO - moztest == 0.8 15:24:45 INFO - mozversion == 1.4 15:24:45 INFO - psutil == 3.1.1 15:24:45 INFO - requests == 1.2.3 15:24:45 INFO - wsgiref == 0.1.2 15:24:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:45 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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6130>, '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 0xea7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea74c0>, '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': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:24:45 INFO - Using env: {'DISPLAY': ':0', 15:24:45 INFO - 'HOME': '/home/cltbld', 15:24:45 INFO - 'LANG': 'en_US.UTF-8', 15:24:45 INFO - 'LANGUAGE': 'en_US:en', 15:24:45 INFO - 'LOGNAME': 'cltbld', 15:24:45 INFO - 'MAIL': '/var/mail/cltbld', 15:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:45 INFO - 'MOZ_NO_REMOTE': '1', 15:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:45 INFO - 'NO_EM_RESTART': '1', 15:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:45 INFO - 'PWD': '/builds/slave/test', 15:24:45 INFO - 'SHELL': '/bin/bash', 15:24:45 INFO - 'SHLVL': '1', 15:24:45 INFO - 'TERM': 'linux', 15:24:45 INFO - 'TMOUT': '86400', 15:24:45 INFO - 'USER': 'cltbld', 15:24:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 15:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:45 INFO - '_': '/tools/buildbot/bin/python'} 15:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:24:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:24:45 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:24:47 INFO - Installing collected packages: simplejson 15:24:47 INFO - Running setup.py install for simplejson 15:24:47 INFO - building 'simplejson._speedups' extension 15:24:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:24:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:24:48 INFO - Successfully installed simplejson 15:24:48 INFO - Cleaning up... 15:24:48 INFO - Return code: 0 15:24:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:48 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 0xb3a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea6130>, '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 0xea7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea74c0>, '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': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:24:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:24:48 INFO - Using env: {'DISPLAY': ':0', 15:24:48 INFO - 'HOME': '/home/cltbld', 15:24:48 INFO - 'LANG': 'en_US.UTF-8', 15:24:48 INFO - 'LANGUAGE': 'en_US:en', 15:24:48 INFO - 'LOGNAME': 'cltbld', 15:24:48 INFO - 'MAIL': '/var/mail/cltbld', 15:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:48 INFO - 'MOZ_NO_REMOTE': '1', 15:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:24:48 INFO - 'NO_EM_RESTART': '1', 15:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:48 INFO - 'PWD': '/builds/slave/test', 15:24:48 INFO - 'SHELL': '/bin/bash', 15:24:48 INFO - 'SHLVL': '1', 15:24:48 INFO - 'TERM': 'linux', 15:24:48 INFO - 'TMOUT': '86400', 15:24:48 INFO - 'USER': 'cltbld', 15:24:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 15:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:48 INFO - '_': '/tools/buildbot/bin/python'} 15:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:24:48 INFO - Cleaning up... 15:24:48 INFO - Return code: 0 15:24:48 INFO - Running post-action listener: _resource_record_post_action 15:24:48 INFO - Running post-action listener: _start_resource_monitoring 15:24:48 INFO - Starting resource monitoring. 15:24:48 INFO - [mozharness: 2017-08-21 22:24:48.501488Z] Finished create-virtualenv step (success) 15:24:48 INFO - [mozharness: 2017-08-21 22:24:48.502001Z] Running install step. 15:24:48 INFO - Running pre-action listener: _resource_record_pre_action 15:24:48 INFO - Running main action method: install 15:24:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:48 INFO - Reading from file tmpfile_stdout 15:24:48 INFO - Detecting whether we're running mozinstall >=1.0... 15:24:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:24:48 INFO - Reading from file tmpfile_stdout 15:24:48 INFO - Output received: 15:24:48 INFO - Usage: mozinstall [options] installer 15:24:48 INFO - Options: 15:24:48 INFO - -h, --help show this help message and exit 15:24:48 INFO - -d DEST, --destination=DEST 15:24:48 INFO - Directory to install application into. [default: 15:24:48 INFO - "/builds/slave/test"] 15:24:48 INFO - --app=APP Application being installed. [default: firefox] 15:24:48 INFO - mkdir: /builds/slave/test/build/application 15:24:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:24:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:25:06 INFO - Reading from file tmpfile_stdout 15:25:06 INFO - Output received: 15:25:06 INFO - /builds/slave/test/build/application/firefox/firefox 15:25:06 INFO - Running post-action listener: _resource_record_post_action 15:25:06 INFO - [mozharness: 2017-08-21 22:25:06.888006Z] Finished install step (success) 15:25:06 INFO - [mozharness: 2017-08-21 22:25:06.888161Z] Running setup-mitmproxy step. 15:25:06 INFO - Running pre-action listener: _resource_record_pre_action 15:25:06 INFO - Running main action method: setup_mitmproxy 15:25:06 INFO - Skipping: mitmproxy is not required 15:25:06 INFO - Running post-action listener: _resource_record_post_action 15:25:06 INFO - [mozharness: 2017-08-21 22:25:06.888695Z] Finished setup-mitmproxy step (success) 15:25:06 INFO - [mozharness: 2017-08-21 22:25:06.888796Z] Running run-tests step. 15:25:06 INFO - Running pre-action listener: _resource_record_pre_action 15:25:06 INFO - Running pre-action listener: _set_gcov_prefix 15:25:06 INFO - Running main action method: run_tests 15:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:25:06 INFO - Python 2.7.3 15:25:06 INFO - Return code: 0 15:25:06 INFO - grabbing minidump binary from tooltool 15:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:25:06 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 0xea6130>, '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 0xea7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea74c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:25:06 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 15:25:06 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 15:25:06 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 15:25:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:25:07 INFO - Return code: 0 15:25:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:25:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:25:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:25:07 INFO - ENV: RUST_BACKTRACE is now full 15:25:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:25:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:25:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:25:07 INFO - Using env: {'DISPLAY': ':0', 15:25:07 INFO - 'HOME': '/home/cltbld', 15:25:07 INFO - 'LANG': 'en_US.UTF-8', 15:25:07 INFO - 'LANGUAGE': 'en_US:en', 15:25:07 INFO - 'LOGNAME': 'cltbld', 15:25:07 INFO - 'MAIL': '/var/mail/cltbld', 15:25:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:25:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:25:07 INFO - 'MOZ_NO_REMOTE': '1', 15:25:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:25:07 INFO - 'NO_EM_RESTART': '1', 15:25:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:25:07 INFO - 'PWD': '/builds/slave/test', 15:25:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:25:07 INFO - 'RUST_BACKTRACE': 'full', 15:25:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:25:07 INFO - 'SHELL': '/bin/bash', 15:25:07 INFO - 'SHLVL': '1', 15:25:07 INFO - 'TERM': 'linux', 15:25:07 INFO - 'TMOUT': '86400', 15:25:07 INFO - 'USER': 'cltbld', 15:25:07 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153', 15:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:25:07 INFO - '_': '/tools/buildbot/bin/python'} 15:25:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:25:07 INFO - mozversion application_buildid: 20170821213051 15:25:07 INFO - mozversion application_changeset: c7570eb46382ee56d081e549b484341f400c864b 15:25:07 INFO - mozversion application_display_name: Nightly 15:25:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:25:07 INFO - mozversion application_name: Firefox 15:25:07 INFO - mozversion application_remotingname: firefox 15:25:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:25:07 INFO - mozversion application_vendor: Mozilla 15:25:07 INFO - mozversion application_version: 57.0a1 15:25:07 INFO - mozversion platform_buildid: 20170821213051 15:25:07 INFO - mozversion platform_changeset: c7570eb46382ee56d081e549b484341f400c864b 15:25:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:25:07 INFO - mozversion platform_version: 57.0a1 15:25:07 INFO - using testdate: 1503354307 15:25:07 INFO - actual date: 1503354307 15:25:07 INFO - starting webserver on 'localhost:43433' 15:25:07 INFO - SUITE-START | Running 2 tests 15:25:07 INFO - TEST-START | dromaeo_css 15:25:07 INFO - Initialising browser for dromaeo_css test... 15:25:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43433/getInfo.html -profile /tmp/tmpP_29iX/profile 15:25:07 INFO - TEST-INFO | started process 21439 (/builds/slave/test/build/application/firefox/firefox http://localhost:43433/getInfo.html) 15:25:13 INFO - TEST-INFO | 21439: exit 0 15:25:13 INFO - Browser initialized. 15:25:13 INFO - Running cycle 1/1 for dromaeo_css test... 15:25:13 INFO - TEST-INFO | started process 21614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP_29iX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:25:14 INFO - PID 21614 | 15:25:14 INFO - PID 21614 | (/builds/slave/test/build/application/firefox/firefox:21664): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:25:14 INFO - PID 21614 | 15:25:14 INFO - PID 21614 | 15:25:14 INFO - PID 21614 | (/builds/slave/test/build/application/firefox/firefox:21718): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:25:14 INFO - PID 21614 | 15:25:15 INFO - PID 21614 | __metrics Screen width/height:1600/1200 15:25:15 INFO - PID 21614 | colorDepth:24 15:25:15 INFO - PID 21614 | Browser inner width/height: 1024/768 15:25:15 INFO - PID 21614 | __metrics 15:25:24 INFO - PID 21614 | RSS: Main: 172179456 15:25:24 INFO - PID 21614 | 15:28:23 INFO - PID 21614 | Cycle 1(1): loaded http://localhost:43433/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43433/tests/dromaeo/cssquery-ext.html) 15:28:24 INFO - PID 21614 | RSS: Main: 175706112 15:28:24 INFO - PID 21614 | 15:31:26 INFO - PID 21614 | Cycle 1(1): loaded http://localhost:43433/tests/dromaeo/cssquery-ext.html (next: http://localhost:43433/tests/dromaeo/cssquery-jquery.html) 15:31:27 INFO - PID 21614 | RSS: Main: 170622976 15:31:27 INFO - PID 21614 | 15:34:29 INFO - PID 21614 | Cycle 1(1): loaded http://localhost:43433/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43433/tests/dromaeo/cssquery-mootools.html) 15:34:29 INFO - PID 21614 | RSS: Main: 173805568 15:34:29 INFO - PID 21614 | 15:37:31 INFO - PID 21614 | Cycle 1(1): loaded http://localhost:43433/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43433/tests/dromaeo/cssquery-prototype.html) 15:37:31 INFO - PID 21614 | RSS: Main: 172855296 15:37:31 INFO - PID 21614 | 15:40:35 INFO - PID 21614 | Cycle 1(1): loaded http://localhost:43433/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43433/tests/dromaeo/cssquery-yui.html) 15:40:36 INFO - PID 21614 | RSS: Main: 176218112 15:40:36 INFO - PID 21614 | 15:43:37 INFO - PID 21614 | Cycle 1(1): loaded http://localhost:43433/tests/dromaeo/cssquery-yui.html (next: http://localhost:43433/tests/dromaeo/cssquery-dojo.html) 15:43:38 INFO - PID 21614 | RSS: Main: 176685056 15:43:38 INFO - PID 21614 | 15:43:38 INFO - PID 21614 | __start_tp_report 15:43:38 INFO - PID 21614 | _x_x_mozilla_page_load 15:43:38 INFO - PID 21614 | _x_x_mozilla_page_load_details 15:43:38 INFO - PID 21614 | |i|pagename|runs| 15:43:38 INFO - PID 21614 | |0;dojo.html;3076.3385872037506;3086.5215891536814;3128.593282873226;3150.2124468882785;3154.6056742907135;6145.969270153654;6264.373562643734;6279.434850863421;6306.8738625227525;6362.236531616201;6115.174451449053;6128.693565321739;6150.969245153768;6153.138560601508;6229.096780966757;5658.660480371171;5685.943140568593;5698.943010569903;5771.942280577204;5776.682282474462;5780.826575202751;5785.27684039495;5809.7676092956235;5823.155642431845;5899.852503687399;5747.942520574804;5778.711064446761;5803.071508558611;5820.738066786984;5844.561657875655;5617.915731264035;5641.379448260688;5670.4896559309445;5677.318721753416;5683.857903552403;5652.321721393418;5675.602707810455;5726.828195154152;5740.737037851666;5750.137479378127;6039.335673075958;6079.331273559905;6094.268687757453;6146.17026701394;6154.72303746328;6576.572522786004;6589.374009469093;6623.834404139887;6625.17185351831;6626.138601981712;6682.966585167043;6688.765893193763;6693.364130407652;6707;6708.060871477997;6169.167162433059;6174.320824709278;6184.226971628546;6188.535859810532;6192.040233763729;6828.146481689789;6884.51808373409;6889.758858440031;6981.127359080115;6982.650867456607;6618.966905165444;6660.500462465335;6668.933310666928;6701.664916754143;6717.16035495563;6680.23177334603;6715.966420167965;6720.630365329856;6779.796606101825;6803.217629972616;6560.868782624416;6612.636305003175;6650.567713098633;6677.198736151693;6684.331566843277;6727.899081513781;6728.831779205461;6752.189737231465;6758.662066896635;6759.188897332351;5384.91922621161;5399.70301633414;5460.91808622863;5470.835874923759;5470.91793623096;4516.1419330327135;4567.063751930847;4591.081783643284;4631.722096674211;4657.184992626277;5767.509761670221;5775.971120144456;5776.277965254343;5798.10129429939;5860.619059761102;6816.318368163244;6817.5909445433435;6818.079559259536;6819.624920629413;6823.965880170567;5795.884082318415;5846.766129354778;5848.795292164754;5879.764809407661;5889.263842019747;5886.8822623547285;5888.352281249059;5973.283206015306;5976.223090998229;5986.880262394815;6443.323451037573;6474.449671777952;6487.708053137526;6583.868322633521;6586.835329116715;6702;6726.529142960141;6773.424258938046;6788.59268443895;6817.42051925572;6549.6070235786;6560.9343906562235;6561.1470508833545;6566.343365663586;6572.671366431564;6612.735490580323;6647.501437392311;6700.329967003261;6715.731370745116;6735.259121496533;6744.258131605421;6747.696353663999;6780.593164410151;6850;6879.208890977602;6547.312532184052;6557.049227862029;6564.704588293443;6567;6584.539082264196;6531.771388001397;6554.606723596599;6571.5399922005;6581.243157037002;6621.801345959629;6456.096146539394;6467.708953097028;6542.803715888531;6555.573887697285;6560.081588577698;6465.870682586416;6527.608343499405;6548.148740663683;6577.50668699859;6598.439132673777;6320.178376810985;6367.777127800505;6386;6386.137871387489;6417.26201486835 15:43:38 INFO - PID 21614 | |1;ext.html;751.7669522448042;808.2644793238154;840.2857571064596;840.798208429977;1167.9532818687253;29549.40901181978;29999.400011999773;30114.54828177579;41041;41720.58279417205;41621.79189104058;42040.57959420405;42107;42251.57748422515;42251.57748422515;7605.125410577772;7681.731139410136;7771.689132434696;7793.883091753628;7797.7660670179985;7618.619069046553;7692.576908270043;7730.420218483609;7733.574653394061;7736.303732664059;7676.309132178103;7747.186545412735;7749.418793590475;7751.108622508399;7769;7689;7729.536227826292;7730.149683534807;7732.652030658605;7733.883991740128;7563.243675632448;7609.353204977529;7611.80970475737;7616.619169041525;7618.580978046205;37772.43341349855;38022.619773802464;38031.239375212615;38104.237915241814;38173.80913095417;3546.3261980223674;3573.4997100405963;3574.571051473814;3580.337637537038;3582.444721068239;31464.685353146404;31506.212344691565;31565.36869262625;31569.368612627848;31665.52501712476;4936.827211047632;4959.231319145538;4966.807966088113;4967.950320496821;4982.526659967298;192766;193109.24117655956;194986;195333;195545;47990.5200947993;48013.5198648009;48038;48440.75779621079;48459.75770121127;51275.48724512782;51305.7434712824;51372.48627513752;51433.22850157251;51467.7426612872;14798.778018329735;14862.70274594502;16316.918415408085;16664.75002874958;16737.246823892954;13560.728785424237;13564.186148831102;13571.86428135706;13608;13613.455461781417;14301.642458938402;14320.785188222186;14332.856671433361;14347.641308967359;14483.275836208148;5573.414791446839;5608.1587761835235;5640.576956728261;5641.802536911188;5688.374278829326;987.9357841740408;997.9501024948723;1003.1824063388315;1005.0602686488157;1016.6492560066913;23039.88480057589;29051.709482905324;29195;29392;30396;1081.4484612847505;1085.625459216569;1087.7171935296722;1093.971666633362;1104.867415910096;12470.189437686522;15532.92233538825;15545.922270388575;15892.443764468188;16068.75896861548;224941;225951;225995;226594;227850;56653;56908.715456422455;57259;57320.42679573235;57367.42632573621;1420.4176287721984;1442.1995792335354;1443.8267407910907;1447.0449503327752;1454.2292584930003;27362.72637273602;27544.449111017268;27982.86008569944;28195;28225.717742822308;51181.48818511916;51901;52100.95798084093;52107.73946130245;52258.95482090261;199723;199765;201370;201639;201785;36309.63690363063;37329.81335093307;38003.23993520059;38020.239595207386;38056.80971595124;45474.54525454703;46169.53830461652;46192;46343.073138537715;46639;33741.15647108842;33968.32063358768;34204.31591368208;34334.65665343415;34578.48132277968;33312.1671958203;33588.832055839564;33683.66316336805;34009;34342.969710908714;36508.63491365052;36642.26715465729;36806;36879.44680829736;37622;32329.838350808095;32469.67530324761;32627.67372326341;32939.50590741093;32939.50590741189;23859.522809544058;24022.39944001414;24110.39724006914;24770.752292477566;25182 15:43:38 INFO - PID 21614 | |2;jquery.html;556.9025420551405;559.9720013999299;561.2619405481794;581.3053401185582;582.2808831093598;21893;22892.198773042946;22939.999999999978;22979.770202297972;23046.999999999956;25124.371890702743;26216.213513594575;27487.587686184725;27514.862425687843;27590.44819103622;6427.58220715652;6563.278039415661;6575.605463672195;6578.769743058994;6590.1432813734145;6050.667213303266;6353.0788035734795;6527.086207930894;6566.310537393552;6587.703553340088;6294.55938084332;6296.496280297565;6299.811005669837;6312.33720459352;6323.841903952415;6253.187085678833;6288.622682639033;6290.779822706229;6300.621962682254;6302.464290535287;5838.357780644125;5847.2983242010805;5860.765569377219;5870.26621672291;5880.764769409261;29291.267718307212;29981.850090749624;30407.69592304071;30647.38705225883;30797.692023079708;1943.319838056683;1992.402279316214;1992.810682985114;1994.311962372979;1995.7704863940542;19020.619587608307;19348;19674;19702.70445943312;19703.704444433344;2408.6868707068143;2449.497852940143;2470.7035155781423;2475.8885850136785;2491.1530079772783;141089;147616.99999999892;148776;149052;149179;14416.351264193136;15108.169050702318;15109.320080596399;15125.924370378078;15317.463888764063;23859.403514912265;23875.761242387354;23895.283141505784;23913.52172956566;23918.880405598207;9764.462954537568;9788.755281117887;9814.165795907285;10010.599576016877;10091.49542522871;8866.77833054166;8928.419652722552;8928.955355223183;9000.279977601776;9018.09819018093;8713;9189.586468608928;9272.258219342437;9471.763205919908;9494.905050949541;2545.567253566898;2589.9223023309332;2626.8029897757747;2632.1313966391044;2711.9728802712116;947.5877993073035;967.8354679704468;977.63827383867;984.2126298960802;991.5934466868694;20260.493487662927;20571.868547230046;20579.279725209544;20611;20674.896625516776;1016.7813920007234;1022.5654097008742;1029.7837454134565;1031.9587216511406;1039.4127318065268;11330.716732081764;11431.657050288504;11457.255278407043;11459.656210313704;11597.710057248636;470098;482419;483082;490085;490764;119787.40106299413;119891.40054299672;123216;123261.38369308096;124237;1220.4934951994824;1230.1266101068163;1248.806435002558;1249.2254802022803;1250.856151542566;17766.733498997266;17950.102494874944;18143;18297.085145742392;18367.17347719329;57387;57558.424415756985;57676;58327.4167258322;59811.40188598058;73033;73168;73199.63400183179;73570.26429735849;73865;12419.627411177678;12891.16207446513;14492.130472171704;14700.41198352054;15214.771778423112;23639.40901477408;23669.881650591637;24131.155409560582;25164.622530661687;25325.113621023174;19402.70895936534;19570.51073723168;19715.901420492806;19787.505312367306;19855.702164467257;17099.829001709822;17386.47840564785;17487.912560437115;17860;18311.81688183101;19579.412617621496;19945.800541994973;20064.799352006878;20091.196352146337;20183.69724454105;14954.40182392692;15102.169380683728;15184.544463666107;15386.846131538541;15391.61520961985;17443.738343925106;17451.127443628022;17466.91266543659;17470.563235919202;19055.71416428727 15:43:38 INFO - PID 21614 | |3;mootools.html;1344.5495758920763;1370.3422357268512;1376.7384197002566;1395.4906459142403;1400.474821941771;14057.50798722045;14616.342264598079;14704.558863234093;14714.77927831082;14747.852521474782;14131.646708832284;15070.397184112622;15083.547493575183;15110.168940708256;15121.09273443594;2654.2700757291705;2710.4714580656682;2710.864456777163;2711.6339294195327;2712.2676877243134;2549.260714392824;2571.524268010424;2607.8565678887653;2708.702042775293;2708.79684023699;2647.245535022519;2653.668291463567;2692.2730862667067;2695.2857492764433;2695.541757901152;2575.6780402449785;2580.883860226285;2595.4938786936555;2628.7634112929736;2628.9868550657316;2589.8705064746687;2627.7766389856884;2628.0670362021588;2630.3818602628367;2631.1711810779543;13969.650758731113;14384;14421.134731916118;14423.78364324536;14424.350904209336;7398;7589.316961473494;7629.160792312841;7646.502977306457;7652.579108149105;4919.2129259318335;5041.521055499722;5094.77073531692;5185.818496352609;5310.787568497255;1609.1632351177439;1616.8383161683855;1663.609051872809;1667.583104223944;1675.061965299424;24676.506469870503;24807.62788558173;24820.25539233826;24862;24958.251252462454;6248.687565621701;6523.673816309166;6525.249596296487;6680.331966803281;6697.397234248941;16266.51200463988;16291;16302.266398012118;16304.103274319788;16329.265183066791;7612.505187162817;7738.226177382329;7740.7677769667;7746.612669366509;7765.262300081597;7076.787696369117;7168.713251469882;7232;7274.527155734966;7295.452841036943;4967.82612608557;5096.643234973516;5130.897382052338;5141.794328226903;5167.586593072545;1333.993330033363;1362.0533729058407;1478.3716920308825;1486.197453375187;1504.9097054176784;881.3830318776882;905.9139381758722;908.0329449136648;913.7213149989184;919.8896132464014;7896.644650990719;8246;8252.257296843312;8293.95853020743;8385.329173666214;967.5210770668564;1004.6684594084081;1005.5123265216364;1008.4050410257983;1009.1976878381704;4840.201366774443;5138.640295179302;5196.688198708014;5212.218167274939;5325.281087053276;19261.422157335302;20208;20508.487287817625;20767.273145439838;20788.58422831535;19989.500262493555;20106.497337566678;20113.99430028493;20206;20209.191632334838;9830.655927042662;10572.947135264274;10608.946955265328;10640.733981650521;10667.19996000303;8024.197580241929;8109.837803243784;8144.429889907887;8241.381896357678;8246.628901699558;17143.742843857603;17266.65466690684;17278.13609319504;17288.22203000843;17438.82561174372;17849.643007139526;17978.460646180636;18019.639607208046;18133.546661333574;18208.45374638763;10207.7448063799;10287.279890407599;10461.424621645883;10464.424456654957;10469.790604188025;12597.43311550964;12741.426635801596;12780;12823.679408014874;12834.037447191311;8804.911950880409;10405.21960852924;10546.894531054591;10784.892151078702;10796;10158;10290.639827605997;10324.22568307395;10443.791124177322;10497.685069447929;9852;9913.206943444651;10009.349392289478;10014.198864091;10018.849717254392;7248.275172482709;7251.1298644163035;7253.455990800817;7280.453965952681;7305.3425191732995;7286.307800758919;7363;7364.3003914628025;7404.444666649915;7528.284812942762 15:43:38 INFO - PID 21614 | |4;prototype.html;502.4098727527375;505.25979440120193;519.3404376441919;520.7734635433584;524.2581746828238;6192.442680158791;6223.315435302113;6231.439170474657;6236.407541283576;6322.747090116395;5905.557083218765;5995.6702381369005;6038.637681739098;6095.3599872013465;6100.816975490731;4870.391201099854;4924.901501969958;4935.5064493550535;4949.356583644121;4966.751662416865;4864.805407783702;4925.817803727097;4963.652544321899;4965.42897566779;4992.625553083533;4866.391701037371;4885.804567817283;4886.975565122169;4927.531884470969;4968.428630707479;4844.685095468801;4862.270659401082;4881.8779530511665;4886.413630364344;4950.579200767939;4380.6276466500385;4401.185780630593;4437.556244375569;4447.799849006802;4460.174867649495;6031.276246850362;6031.849203769897;6038.124471951586;6064.696765161724;6113.419225173601;5600.4959553639965;5639.68981706006;5663.2637757091725;5663.320401551799;5683.488486036235;6391.169148010729;6403.903941440882;6448.355164483561;6467.902981455282;6545.476361891037;4848.684835485682;4848.951510484921;4857.975710121462;4871.707697538159;4901.65688401812;6842.623655698984;6859.451243900476;6859.5541289816;6873.140857392826;6948.583085014865;4948.628852836052;4972.129877271463;5003.022597035366;5006.249062640633;5019.795249140253;5048.394192696826;5072.137736584789;5084.669496482717;5094.465081166498;5121.4622464641425;5638.295213098363;5725.8568535786935;5732;5747.195392645033;5749.671383089855;6412.8777463943625;6548.672566371758;6554.9672251639395;6558.442532384801;6565.277819439858;1660.418853401324;1704.7613334132984;1722.6554689062239;1749.5713550180033;1758.7512865865124;1216.2216181643755;1218.9817152742717;1243.2975368916534;1250.7435975625158;1254.4229654358915;5735.799247026334;5746.166805813134;5750;5757.395473475225;5766.798162064308;6572.474202063823;6677.933220667828;6679.699413526403;6702.151585576208;6714.227863795726;5666.829995100154;5668.234788303526;5675.886482270332;5737.598368114275;5753.223314852525;3528.400171970771;3535.469679548088;3582.6954708849516;3583.5844841287544;3584.5877724061547;6412.551121421549;6492.64290464029;6535.451174042128;6535.797459244935;6565.967170164214;6824.7952561423235;6891.27641597635;6912.55068420551;6916.377526022682;6923.723051078001;6409.198850143732;6441.516886233458;6457.838554036187;6458.128152699325;6547.214334279917;6653.7709867195035;6686.29793871656;6742.25835158142;6757.797266082025;6774.42417394527;6654.567453115532;6681.46548276127;6683.6324002180345;6706.6646667665445;6736.191657001191;6516.380943810331;6538.384646141391;6552.443042341454;6583.267943803268;6617.602943823386;4914.65597408178;4922.655414120977;4928.841722195353;4931.654784165074;4971.279164521196;6453.45145662624;6625.072489851328;6685.364890335411;6696.7656132035145;6718.193816742022;6241.781537646342;6373.362663733589;6427.132337134427;6454.322296159024;6500.479961603155;6380;6393.506532452254;6417.550771445954;6469.288378278292;6511.641859697573;6301.495880329471;6321.905171422524;6328.240611126695;6340.30256671775;6350.555461117678;6451.967740161457;6459.224893012869;6470.029495575702;6508.869822603616;6509.576877502947;6265.342139075331;6295.811125666238;6311.506954752938;6332.968335158294;6337.841553961188 15:43:38 INFO - PID 21614 | |5;yui.html;910.1171863292608;912.5528491039389;921.3412410126758;923.5936188077246;932.5057719408716;18763.81236187638;19757.110930008166;19761;19780.604387912234;19796.70304945427;17625.7356139658;18165.636687266247;22004;22009.33971980839;22116.33650990469;1031.6853359725299;1044.7858189071221;1048.8007278617038;1050.9421981791;1053.2627160987302;1008.4134195787817;1036.2538971940228;1073.527647834954;1076.0476977874598;1076.3004047369195;1093.5079214353532;1093.5899037860802;1096.2819353323587;1099.2744788439632;1119.8768135505088;1086.2342048855537;1090.2749671468464;1093.2128867215592;1094.9945250273777;1103.4979084516565;795.8806179073127;795.9044914610283;795.932345750612;800.0599295827379;816.6814942172557;18424.355147569906;18498.2600695972;18682.906585466986;18707.34524291643;20050.398488045383;21301.68047479289;21375.786242137536;21555.67666484988;21785.237516686997;21830.45423864416;15993.20033998307;16114.597135071599;16252.268647910872;16279;16592.502224933272;3622.0582648511577;3647.8723244686307;3649.1424515238896;3650.7444478886487;3660.5973342932257;116647.99999999916;117797;120601;121764;123536.38231808873;16812.41156559539;17414.390496332566;17488.213030413663;17499.037552934456;17747.46757597274;30627.69372306293;30710;31404.371912561623;31419.528707069414;31428.37143257122;8543.871841922377;8612.956935215283;8613.48319100856;8632.309415246766;8655.826883462296;4166.66666666666;4237.300845360543;4241.575842415734;4242;4248.766317852548;4637.623367560603;4779.569838714463;4787.952120478821;4791.520847915181;4811.446683631357;1020.4795554267378;1040.4381633917599;1055.4353420919772;1058.296233005043;1059.692689120162;610.8198081565948;664.4285914113858;688.5593220338988;692.8060143159923;701.551007355293;11136.554537818558;11211.383373914514;11396.373199474108;11417.20079594437;12297.692557686129;616.1804799616499;616.8149555133442;638.0811631250983;656.7766959233884;669.5647828911247;5196.974015129976;5483.122700367922;5503.9174412383845;5542.168674698827;6005.129256257906;107322;107735.46132269288;109987.45006274918;111948;113657.4317128409;94424.52787736017;96090;96606.51696741612;99666.5016674912;101529.49235253777;85859.99999999875;87637;88385;88511.55744221238;90840;11094;11262.493187806733;11560.364179970182;11957.222780519238;12166.270023798601;38716.80641596774;39884;40400;40590;42074.57925420706;66806;68339;69950.65024674844;73594.63202683952;74153;17662.470125896245;17721.468355949342;18054.5486362842;18128.18423170934;18186;19806.405807825788;19949.800501994796;20187.79812201859;20218.89890550538;20439.8978005115;17439.128043597517;17575.384861529787;17612.207450665006;17699.91150044293;17917.910410447865;16634.50096497107;16744.832551674815;16839.494815155565;16987.745183822004;17000.404985825437;17756.46730598084;17988.55028624295;18011.369602063864;18032.90983545074;18118.637627247645;12580.370981451073;12653.304068276333;12826.294553799631;12839.743205136032;12859;13535.120217185851;13771.655708607364;13858.65353366174;13940.442382304595;13958.441662333798 15:43:38 INFO - PID 21614 | __end_tp_report 15:43:38 INFO - PID 21614 | __start_cc_report 15:43:38 INFO - PID 21614 | _x_x_mozilla_cycle_collect,396 15:43:38 INFO - PID 21614 | __end_cc_report 15:43:38 INFO - PID 21614 | __startTimestamp1503355418054__endTimestamp 15:43:38 INFO - PID 21614 | 15:43:38 INFO - PID 21614 | ------- Summary: start ------- 15:43:38 INFO - PID 21614 | Number of tests: 6 15:43:38 INFO - PID 21614 | 15:43:38 INFO - PID 21614 | [#0] dojo.html Cycles:165 Average:6178.23 Median:6465.87 stddev:742.83 (11.5%) stddev-sans-first:704.13 15:43:38 INFO - PID 21614 | Values: 3076.3 3086.5 3128.6 3150.2 3154.6 6146.0 6264.4 6279.4 6306.9 6362.2 6115.2 6128.7 6151.0 6153.1 6229.1 5658.7 5685.9 5698.9 5771.9 5776.7 5780.8 5785.3 5809.8 5823.2 5899.9 5747.9 5778.7 5803.1 5820.7 5844.6 5617.9 5641.4 5670.5 5677.3 5683.9 5652.3 5675.6 5726.8 5740.7 5750.1 6039.3 6079.3 6094.3 6146.2 6154.7 6576.6 6589.4 6623.8 6625.2 6626.1 6683.0 6688.8 6693.4 6707.0 6708.1 6169.2 6174.3 6184.2 6188.5 6192.0 6828.1 6884.5 6889.8 6981.1 6982.7 6619.0 6660.5 6668.9 6701.7 6717.2 6680.2 6716.0 6720.6 6779.8 6803.2 6560.9 6612.6 6650.6 6677.2 6684.3 6727.9 6728.8 6752.2 6758.7 6759.2 5384.9 5399.7 5460.9 5470.8 5470.9 4516.1 4567.1 4591.1 4631.7 4657.2 5767.5 5776.0 5776.3 5798.1 5860.6 6816.3 6817.6 6818.1 6819.6 6824.0 5795.9 5846.8 5848.8 5879.8 5889.3 5886.9 5888.4 5973.3 5976.2 5986.9 6443.3 6474.4 6487.7 6583.9 6586.8 6702.0 6726.5 6773.4 6788.6 6817.4 6549.6 6560.9 6561.1 6566.3 6572.7 6612.7 6647.5 6700.3 6715.7 6735.3 6744.3 6747.7 6780.6 6850.0 6879.2 6547.3 6557.0 6564.7 6567.0 6584.5 6531.8 6554.6 6571.5 6581.2 6621.8 6456.1 6467.7 6542.8 6555.6 6560.1 6465.9 6527.6 6548.1 6577.5 6598.4 6320.2 6367.8 6386.0 6386.1 6417.3 15:43:38 INFO - PID 21614 | 15:43:38 INFO - PID 21614 | [#1] ext.html Cycles:180 Average:38717.59 Median:3581.39 stddev:53740.59 (1500.6%) stddev-sans-first:53815.73 15:43:38 INFO - PID 21614 | Values: 751.8 808.3 840.3 840.8 1168.0 29549.4 29999.4 30114.5 41041.0 41720.6 41621.8 42040.6 42107.0 42251.6 42251.6 7605.1 7681.7 7771.7 7793.9 7797.8 7618.6 7692.6 7730.4 7733.6 7736.3 7676.3 7747.2 7749.4 7751.1 7769.0 7689.0 7729.5 7730.1 7732.7 7733.9 7563.2 7609.4 7611.8 7616.6 7618.6 37772.4 38022.6 38031.2 38104.2 38173.8 3546.3 3573.5 3574.6 3580.3 3582.4 31464.7 31506.2 31565.4 31569.4 31665.5 4936.8 4959.2 4966.8 4968.0 4982.5 192766.0 193109.2 194986.0 195333.0 195545.0 47990.5 48013.5 48038.0 48440.8 48459.8 51275.5 51305.7 51372.5 51433.2 51467.7 14798.8 14862.7 16316.9 16664.8 16737.2 13560.7 13564.2 13571.9 13608.0 13613.5 14301.6 14320.8 14332.9 14347.6 14483.3 5573.4 5608.2 5640.6 5641.8 5688.4 987.9 998.0 1003.2 1005.1 1016.6 23039.9 29051.7 29195.0 29392.0 30396.0 1081.4 1085.6 1087.7 1094.0 1104.9 12470.2 15532.9 15545.9 15892.4 16068.8 224941.0 225951.0 225995.0 226594.0 227850.0 56653.0 56908.7 57259.0 57320.4 57367.4 1420.4 1442.2 1443.8 1447.0 1454.2 27362.7 27544.4 27982.9 28195.0 28225.7 51181.5 51901.0 52101.0 52107.7 52259.0 199723.0 199765.0 201370.0 201639.0 201785.0 36309.6 37329.8 38003.2 38020.2 38056.8 45474.5 46169.5 46192.0 46343.1 46639.0 33741.2 33968.3 34204.3 34334.7 34578.5 33312.2 33588.8 33683.7 34009.0 34343.0 36508.6 36642.3 36806.0 36879.4 37622.0 32329.8 32469.7 32627.7 32939.5 32939.5 23859.5 24022.4 24110.4 24770.8 25182.0 15:43:38 INFO - PID 21614 | 15:43:38 INFO - PID 21614 | [#2] jquery.html Cycles:180 Average:35311.97 Median:23885.52 stddev:82080.35 (343.6%) stddev-sans-first:82269.12 15:43:38 INFO - PID 21614 | Values: 556.9 560.0 561.3 581.3 582.3 21893.0 22892.2 22940.0 22979.8 23047.0 25124.4 26216.2 27487.6 27514.9 27590.4 6427.6 6563.3 6575.6 6578.8 6590.1 6050.7 6353.1 6527.1 6566.3 6587.7 6294.6 6296.5 6299.8 6312.3 6323.8 6253.2 6288.6 6290.8 6300.6 6302.5 5838.4 5847.3 5860.8 5870.3 5880.8 29291.3 29981.9 30407.7 30647.4 30797.7 1943.3 1992.4 1992.8 1994.3 1995.8 19020.6 19348.0 19674.0 19702.7 19703.7 2408.7 2449.5 2470.7 2475.9 2491.2 141089.0 147617.0 148776.0 149052.0 149179.0 14416.4 15108.2 15109.3 15125.9 15317.5 23859.4 23875.8 23895.3 23913.5 23918.9 9764.5 9788.8 9814.2 10010.6 10091.5 8866.8 8928.4 8929.0 9000.3 9018.1 8713.0 9189.6 9272.3 9471.8 9494.9 2545.6 2589.9 2626.8 2632.1 2712.0 947.6 967.8 977.6 984.2 991.6 20260.5 20571.9 20579.3 20611.0 20674.9 1016.8 1022.6 1029.8 1032.0 1039.4 11330.7 11431.7 11457.3 11459.7 11597.7 470098.0 482419.0 483082.0 490085.0 490764.0 119787.4 119891.4 123216.0 123261.4 124237.0 1220.5 1230.1 1248.8 1249.2 1250.9 17766.7 17950.1 18143.0 18297.1 18367.2 57387.0 57558.4 57676.0 58327.4 59811.4 73033.0 73168.0 73199.6 73570.3 73865.0 12419.6 12891.2 14492.1 14700.4 15214.8 23639.4 23669.9 24131.2 25164.6 25325.1 19402.7 19570.5 19715.9 19787.5 19855.7 17099.8 17386.5 17487.9 17860.0 18311.8 19579.4 19945.8 20064.8 20091.2 20183.7 14954.4 15102.2 15184.5 15386.8 15391.6 17443.7 17451.1 17466.9 17470.6 19055.7 15:43:38 INFO - PID 21614 | 15:43:38 INFO - PID 21614 | [#3] mootools.html Cycles:180 Average:8885.02 Median:2560.39 stddev:6229.26 (243.3%) stddev-sans-first:6220.97 15:43:38 INFO - PID 21614 | Values: 1344.5 1370.3 1376.7 1395.5 1400.5 14057.5 14616.3 14704.6 14714.8 14747.9 14131.6 15070.4 15083.5 15110.2 15121.1 2654.3 2710.5 2710.9 2711.6 2712.3 2549.3 2571.5 2607.9 2708.7 2708.8 2647.2 2653.7 2692.3 2695.3 2695.5 2575.7 2580.9 2595.5 2628.8 2629.0 2589.9 2627.8 2628.1 2630.4 2631.2 13969.7 14384.0 14421.1 14423.8 14424.4 7398.0 7589.3 7629.2 7646.5 7652.6 4919.2 5041.5 5094.8 5185.8 5310.8 1609.2 1616.8 1663.6 1667.6 1675.1 24676.5 24807.6 24820.3 24862.0 24958.3 6248.7 6523.7 6525.2 6680.3 6697.4 16266.5 16291.0 16302.3 16304.1 16329.3 7612.5 7738.2 7740.8 7746.6 7765.3 7076.8 7168.7 7232.0 7274.5 7295.5 4967.8 5096.6 5130.9 5141.8 5167.6 1334.0 1362.1 1478.4 1486.2 1504.9 881.4 905.9 908.0 913.7 919.9 7896.6 8246.0 8252.3 8294.0 8385.3 967.5 1004.7 1005.5 1008.4 1009.2 4840.2 5138.6 5196.7 5212.2 5325.3 19261.4 20208.0 20508.5 20767.3 20788.6 19989.5 20106.5 20114.0 20206.0 20209.2 9830.7 10572.9 10608.9 10640.7 10667.2 8024.2 8109.8 8144.4 8241.4 8246.6 17143.7 17266.7 17278.1 17288.2 17438.8 17849.6 17978.5 18019.6 18133.5 18208.5 10207.7 10287.3 10461.4 10464.4 10469.8 12597.4 12741.4 12780.0 12823.7 12834.0 8804.9 10405.2 10546.9 10784.9 10796.0 10158.0 10290.6 10324.2 10443.8 10497.7 9852.0 9913.2 10009.3 10014.2 10018.8 7248.3 7251.1 7253.5 7280.5 7305.3 7286.3 7363.0 7364.3 7404.4 7528.3 15:43:38 INFO - PID 21614 | 15:43:38 INFO - PID 21614 | [#4] prototype.html Cycles:180 Average:5474.87 Median:6051.67 stddev:1536.65 (25.4%) stddev-sans-first:1494.95 15:43:38 INFO - PID 21614 | Values: 502.4 505.3 519.3 520.8 524.3 6192.4 6223.3 6231.4 6236.4 6322.7 5905.6 5995.7 6038.6 6095.4 6100.8 4870.4 4924.9 4935.5 4949.4 4966.8 4864.8 4925.8 4963.7 4965.4 4992.6 4866.4 4885.8 4887.0 4927.5 4968.4 4844.7 4862.3 4881.9 4886.4 4950.6 4380.6 4401.2 4437.6 4447.8 4460.2 6031.3 6031.8 6038.1 6064.7 6113.4 5600.5 5639.7 5663.3 5663.3 5683.5 6391.2 6403.9 6448.4 6467.9 6545.5 4848.7 4849.0 4858.0 4871.7 4901.7 6842.6 6859.5 6859.6 6873.1 6948.6 4948.6 4972.1 5003.0 5006.2 5019.8 5048.4 5072.1 5084.7 5094.5 5121.5 5638.3 5725.9 5732.0 5747.2 5749.7 6412.9 6548.7 6555.0 6558.4 6565.3 1660.4 1704.8 1722.7 1749.6 1758.8 1216.2 1219.0 1243.3 1250.7 1254.4 5735.8 5746.2 5750.0 5757.4 5766.8 6572.5 6677.9 6679.7 6702.2 6714.2 5666.8 5668.2 5675.9 5737.6 5753.2 3528.4 3535.5 3582.7 3583.6 3584.6 6412.6 6492.6 6535.5 6535.8 6566.0 6824.8 6891.3 6912.6 6916.4 6923.7 6409.2 6441.5 6457.8 6458.1 6547.2 6653.8 6686.3 6742.3 6757.8 6774.4 6654.6 6681.5 6683.6 6706.7 6736.2 6516.4 6538.4 6552.4 6583.3 6617.6 4914.7 4922.7 4928.8 4931.7 4971.3 6453.5 6625.1 6685.4 6696.8 6718.2 6241.8 6373.4 6427.1 6454.3 6500.5 6380.0 6393.5 6417.6 6469.3 6511.6 6301.5 6321.9 6328.2 6340.3 6350.6 6452.0 6459.2 6470.0 6508.9 6509.6 6265.3 6295.8 6311.5 6333.0 6337.8 15:43:38 INFO - PID 21614 | 15:43:38 INFO - PID 21614 | [#5] yui.html Cycles:180 Average:23542.77 Median:18695.13 stddev:31776.11 (170.0%) stddev-sans-first:31819.80 15:43:38 INFO - PID 21614 | Values: 910.1 912.6 921.3 923.6 932.5 18763.8 19757.1 19761.0 19780.6 19796.7 17625.7 18165.6 22004.0 22009.3 22116.3 1031.7 1044.8 1048.8 1050.9 1053.3 1008.4 1036.3 1073.5 1076.0 1076.3 1093.5 1093.6 1096.3 1099.3 1119.9 1086.2 1090.3 1093.2 1095.0 1103.5 795.9 795.9 795.9 800.1 816.7 18424.4 18498.3 18682.9 18707.3 20050.4 21301.7 21375.8 21555.7 21785.2 21830.5 15993.2 16114.6 16252.3 16279.0 16592.5 3622.1 3647.9 3649.1 3650.7 3660.6 116648.0 117797.0 120601.0 121764.0 123536.4 16812.4 17414.4 17488.2 17499.0 17747.5 30627.7 30710.0 31404.4 31419.5 31428.4 8543.9 8613.0 8613.5 8632.3 8655.8 4166.7 4237.3 4241.6 4242.0 4248.8 4637.6 4779.6 4788.0 4791.5 4811.4 1020.5 1040.4 1055.4 1058.3 1059.7 610.8 664.4 688.6 692.8 701.6 11136.6 11211.4 11396.4 11417.2 12297.7 616.2 616.8 638.1 656.8 669.6 5197.0 5483.1 5503.9 5542.2 6005.1 107322.0 107735.5 109987.5 111948.0 113657.4 94424.5 96090.0 96606.5 99666.5 101529.5 85860.0 87637.0 88385.0 88511.6 90840.0 11094.0 11262.5 11560.4 11957.2 12166.3 38716.8 39884.0 40400.0 40590.0 42074.6 66806.0 68339.0 69950.7 73594.6 74153.0 17662.5 17721.5 18054.5 18128.2 18186.0 19806.4 19949.8 20187.8 20218.9 20439.9 17439.1 17575.4 17612.2 17699.9 17917.9 16634.5 16744.8 16839.5 16987.7 17000.4 17756.5 17988.6 18011.4 18032.9 18118.6 12580.4 12653.3 12826.3 12839.7 12859.0 13535.1 13771.7 13858.7 13940.4 13958.4 15:43:38 INFO - PID 21614 | -------- Summary: end -------- 15:43:38 INFO - PID 21614 | 15:43:38 INFO - TEST-INFO | 21614: exit 0 15:43:38 INFO - TEST-OK | dromaeo_css | took 1111508ms 15:43:38 INFO - TEST-START | kraken 15:43:38 INFO - Initialising browser for kraken test... 15:43:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43433/getInfo.html -profile /tmp/tmpIZ54yc/profile 15:43:38 INFO - TEST-INFO | started process 22025 (/builds/slave/test/build/application/firefox/firefox http://localhost:43433/getInfo.html) 15:43:44 INFO - TEST-INFO | 22025: exit 0 15:43:44 INFO - Browser initialized. 15:43:44 INFO - Running cycle 1/1 for kraken test... 15:43:44 INFO - TEST-INFO | started process 22200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIZ54yc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:43:45 INFO - PID 22200 | 15:43:45 INFO - PID 22200 | (/builds/slave/test/build/application/firefox/firefox:22249): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:43:45 INFO - PID 22200 | 15:43:46 INFO - PID 22200 | 15:43:46 INFO - PID 22200 | (/builds/slave/test/build/application/firefox/firefox:22302): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:43:46 INFO - PID 22200 | 15:43:46 INFO - PID 22200 | __metrics Screen width/height:1600/1200 15:43:46 INFO - PID 22200 | colorDepth:24 15:43:46 INFO - PID 22200 | Browser inner width/height: 1024/768 15:43:46 INFO - PID 22200 | __metrics 15:43:55 INFO - PID 22200 | RSS: Main: 171442176 15:43:55 INFO - PID 22200 | 15:43:58 INFO - PID 22200 | Cycle 1(1): loaded http://localhost:43433/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43433/tests/kraken/driver.html?testName=audio-beat-detection) 15:43:59 INFO - PID 22200 | RSS: Main: 175472640 15:43:59 INFO - PID 22200 | 15:44:02 INFO - PID 22200 | Cycle 1(1): loaded http://localhost:43433/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43433/tests/kraken/driver.html?testName=audio-dft) 15:44:02 INFO - PID 22200 | RSS: Main: 176099328 15:44:02 INFO - PID 22200 | 15:44:05 INFO - PID 22200 | Cycle 1(1): loaded http://localhost:43433/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43433/tests/kraken/driver.html?testName=audio-fft) 15:44:06 INFO - PID 22200 | RSS: Main: 169570304 15:44:06 INFO - PID 22200 | 15:44:08 INFO - PID 22200 | Cycle 1(1): loaded http://localhost:43433/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43433/tests/kraken/driver.html?testName=audio-oscillator) 15:44:09 INFO - PID 22200 | RSS: Main: 170135552 15:44:09 INFO - PID 22200 | 15:44:11 INFO - PID 22200 | Cycle 1(1): loaded http://localhost:43433/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43433/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:44:11 INFO - PID 22200 | RSS: Main: 170840064 15:44:11 INFO - PID 22200 | 15:44:14 INFO - PID 22200 | Cycle 1(1): loaded http://localhost:43433/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43433/tests/kraken/driver.html?testName=imaging-darkroom) 15:44:15 INFO - PID 22200 | RSS: Main: 171819008 15:44:15 INFO - PID 22200 | 15:44:19 INFO - PID 22200 | Cycle 1(1): loaded http://localhost:43433/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43433/tests/kraken/driver.html?testName=imaging-desaturate) 15:44:19 INFO - PID 22200 | RSS: Main: 172421120 15:44:19 INFO - PID 22200 | 15:44:22 INFO - PID 22200 | Cycle 1(1): loaded http://localhost:43433/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43433/tests/kraken/driver.html?testName=json-parse-financial) 15:44:23 INFO - PID 22200 | RSS: Main: 172335104 15:44:23 INFO - PID 22200 | 15:44:24 INFO - PID 22200 | Cycle 1(1): loaded http://localhost:43433/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43433/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:44:25 INFO - PID 22200 | RSS: Main: 172130304 15:44:25 INFO - PID 22200 | 15:44:27 INFO - PID 22200 | Cycle 1(1): loaded http://localhost:43433/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43433/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:44:27 INFO - PID 22200 | RSS: Main: 172982272 15:44:27 INFO - PID 22200 | 15:44:29 INFO - PID 22200 | Cycle 1(1): loaded http://localhost:43433/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43433/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:44:30 INFO - PID 22200 | RSS: Main: 173047808 15:44:30 INFO - PID 22200 | 15:44:33 INFO - PID 22200 | Cycle 1(1): loaded http://localhost:43433/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43433/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:44:33 INFO - PID 22200 | RSS: Main: 172879872 15:44:33 INFO - PID 22200 | 15:44:36 INFO - PID 22200 | Cycle 1(1): loaded http://localhost:43433/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43433/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:44:37 INFO - PID 22200 | RSS: Main: 173412352 15:44:37 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | Cycle 1(1): loaded http://localhost:43433/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43433/tests/kraken/driver.html?testName=ai-astar) 15:44:39 INFO - PID 22200 | RSS: Main: 174796800 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | __start_tp_report 15:44:39 INFO - PID 22200 | _x_x_mozilla_page_load 15:44:39 INFO - PID 22200 | _x_x_mozilla_page_load_details 15:44:39 INFO - PID 22200 | |i|pagename|runs| 15:44:39 INFO - PID 22200 | |0;ai-astar;98;113;101;109;107;108;110;99;108;109 15:44:39 INFO - PID 22200 | |1;audio-beat-detection;141;118;147;186;119;144;152;119;176;117 15:44:39 INFO - PID 22200 | |2;audio-dft;163;163;164;163;163;164;162;163;165;167 15:44:39 INFO - PID 22200 | |3;audio-fft;74;74;76;181;77;76;73;75;174;75 15:44:39 INFO - PID 22200 | |4;audio-oscillator;80;80;130;78;78;79;128;79;79;122 15:44:39 INFO - PID 22200 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;114;115;115 15:44:39 INFO - PID 22200 | |6;imaging-darkroom;157;150;153;151;149;149;149;151;152;151 15:44:39 INFO - PID 22200 | |7;imaging-desaturate;94;95;94;94;94;95;93;95;94;95 15:44:39 INFO - PID 22200 | |8;json-parse-financial;54;53;53;54;58;54;54;53;53;53 15:44:39 INFO - PID 22200 | |9;json-stringify-tinderbox;54;55;54;55;55;55;55;55;55;57 15:44:39 INFO - PID 22200 | |10;stanford-crypto-aes;75;77;78;76;77;75;75;82;79;76 15:44:39 INFO - PID 22200 | |11;stanford-crypto-ccm;128;125;123;124;120;136;137;127;123;166 15:44:39 INFO - PID 22200 | |12;stanford-crypto-pbkdf2;177;196;185;173;171;174;177;172;173;175 15:44:39 INFO - PID 22200 | |13;stanford-crypto-sha256-iterative;71;70;72;72;68;68;67;69;66;69 15:44:39 INFO - PID 22200 | __end_tp_report 15:44:39 INFO - PID 22200 | __start_cc_report 15:44:39 INFO - PID 22200 | _x_x_mozilla_cycle_collect,953 15:44:39 INFO - PID 22200 | __end_cc_report 15:44:39 INFO - PID 22200 | __startTimestamp1503355479637__endTimestamp 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | ------- Summary: start ------- 15:44:39 INFO - PID 22200 | Number of tests: 14 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | [#0] ai-astar Cycles:10 Average:106.20 Median:109.50 stddev:5.05 (4.6%) stddev-sans-first:4.40 15:44:39 INFO - PID 22200 | Values: 98.0 113.0 101.0 109.0 107.0 108.0 110.0 99.0 108.0 109.0 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:145.50 stddev:24.68 (17.0%) stddev-sans-first:26.17 15:44:39 INFO - PID 22200 | Values: 141.0 118.0 147.0 186.0 119.0 144.0 152.0 119.0 176.0 117.0 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:1.42 (0.9%) stddev-sans-first:1.48 15:44:39 INFO - PID 22200 | Values: 163.0 163.0 164.0 163.0 163.0 164.0 162.0 163.0 165.0 167.0 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | [#3] audio-fft Cycles:10 Average:95.50 Median:75.00 stddev:43.26 (57.7%) stddev-sans-first:45.18 15:44:39 INFO - PID 22200 | Values: 74.0 74.0 76.0 181.0 77.0 76.0 73.0 75.0 174.0 75.0 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:79.00 stddev:23.12 (29.3%) stddev-sans-first:24.01 15:44:39 INFO - PID 22200 | Values: 80.0 80.0 130.0 78.0 78.0 79.0 128.0 79.0 79.0 122.0 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:44:39 INFO - PID 22200 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 115.0 115.0 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:151.00 stddev:2.44 (1.6%) stddev-sans-first:1.42 15:44:39 INFO - PID 22200 | Values: 157.0 150.0 153.0 151.0 149.0 149.0 149.0 151.0 152.0 151.0 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 15:44:39 INFO - PID 22200 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 93.0 95.0 94.0 95.0 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.52 (2.8%) stddev-sans-first:1.62 15:44:39 INFO - PID 22200 | Values: 54.0 53.0 53.0 54.0 58.0 54.0 54.0 53.0 53.0 53.0 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:55.00 stddev:0.82 (1.5%) stddev-sans-first:0.78 15:44:39 INFO - PID 22200 | Values: 54.0 55.0 54.0 55.0 55.0 55.0 55.0 55.0 55.0 57.0 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:77.00 stddev:2.21 (2.9%) stddev-sans-first:2.22 15:44:39 INFO - PID 22200 | Values: 75.0 77.0 78.0 76.0 77.0 75.0 75.0 82.0 79.0 76.0 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:127.50 stddev:13.52 (10.6%) stddev-sans-first:14.30 15:44:39 INFO - PID 22200 | Values: 128.0 125.0 123.0 124.0 120.0 136.0 137.0 127.0 123.0 166.0 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:176.00 stddev:7.67 (4.4%) stddev-sans-first:8.14 15:44:39 INFO - PID 22200 | Values: 177.0 196.0 185.0 173.0 171.0 174.0 177.0 172.0 173.0 175.0 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:2.04 (2.9%) stddev-sans-first:2.06 15:44:39 INFO - PID 22200 | Values: 71.0 70.0 72.0 72.0 68.0 68.0 67.0 69.0 66.0 69.0 15:44:39 INFO - PID 22200 | -------- Summary: end -------- 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | 15:44:39 INFO - PID 22200 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 15:44:39 INFO - PID 22200 | 15:44:40 INFO - PID 22200 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:44:40 INFO - TEST-INFO | 22200: exit 0 15:44:40 INFO - TEST-OK | kraken | took 61619ms 15:44:40 INFO - SUITE-END | took 1173s 15:44:40 INFO - Completed test suite (00:19:33) 15:44:40 INFO - javascript benchmark 15:44:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8530.45416310499, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3076.3385872037506, 3086.5215891536814, 3128.593282873226, 3150.2124468882785, 3154.6056742907135, 6145.969270153654, 6264.373562643734, 6279.434850863421, 6306.8738625227525, 6362.236531616201, 6115.174451449053, 6128.693565321739, 6150.969245153768, 6153.138560601508, 6229.096780966757, 5658.660480371171, 5685.943140568593, 5698.943010569903, 5771.942280577204, 5776.682282474462, 5780.826575202751, 5785.27684039495, 5809.7676092956235, 5823.155642431845, 5899.852503687399, 5747.942520574804, 5778.711064446761, 5803.071508558611, 5820.738066786984, 5844.561657875655, 5617.915731264035, 5641.379448260688, 5670.4896559309445, 5677.318721753416, 5683.857903552403, 5652.321721393418, 5675.602707810455, 5726.828195154152, 5740.737037851666, 5750.137479378127, 6039.335673075958, 6079.331273559905, 6094.268687757453, 6146.17026701394, 6154.72303746328, 6576.572522786004, 6589.374009469093, 6623.834404139887, 6625.17185351831, 6626.138601981712, 6682.966585167043, 6688.765893193763, 6693.364130407652, 6707.0, 6708.060871477997, 6169.167162433059, 6174.320824709278, 6184.226971628546, 6188.535859810532, 6192.040233763729, 6828.146481689789, 6884.51808373409, 6889.758858440031, 6981.127359080115, 6982.650867456607, 6618.966905165444, 6660.500462465335, 6668.933310666928, 6701.664916754143, 6717.16035495563, 6680.23177334603, 6715.966420167965, 6720.630365329856, 6779.796606101825, 6803.217629972616, 6560.868782624416, 6612.636305003175, 6650.567713098633, 6677.198736151693, 6684.331566843277, 6727.899081513781, 6728.831779205461, 6752.189737231465, 6758.662066896635, 6759.188897332351, 5384.91922621161, 5399.70301633414, 5460.91808622863, 5470.835874923759, 5470.91793623096, 4516.1419330327135, 4567.063751930847, 4591.081783643284, 4631.722096674211, 4657.184992626277, 5767.509761670221, 5775.971120144456, 5776.277965254343, 5798.10129429939, 5860.619059761102, 6816.318368163244, 6817.5909445433435, 6818.079559259536, 6819.624920629413, 6823.965880170567, 5795.884082318415, 5846.766129354778, 5848.795292164754, 5879.764809407661, 5889.263842019747, 5886.8822623547285, 5888.352281249059, 5973.283206015306, 5976.223090998229, 5986.880262394815, 6443.323451037573, 6474.449671777952, 6487.708053137526, 6583.868322633521, 6586.835329116715, 6702.0, 6726.529142960141, 6773.424258938046, 6788.59268443895, 6817.42051925572, 6549.6070235786, 6560.9343906562235, 6561.1470508833545, 6566.343365663586, 6572.671366431564, 6612.735490580323, 6647.501437392311, 6700.329967003261, 6715.731370745116, 6735.259121496533, 6744.258131605421, 6747.696353663999, 6780.593164410151, 6850.0, 6879.208890977602, 6547.312532184052, 6557.049227862029, 6564.704588293443, 6567.0, 6584.539082264196, 6531.771388001397, 6554.606723596599, 6571.5399922005, 6581.243157037002, 6621.801345959629, 6456.096146539394, 6467.708953097028, 6542.803715888531, 6555.573887697285, 6560.081588577698, 6465.870682586416, 6527.608343499405, 6548.148740663683, 6577.50668699859, 6598.439132673777, 6320.178376810985, 6367.777127800505, 6386.0, 6386.137871387489, 6417.26201486835], "value": 6120.934100214668, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.7669522448042, 808.2644793238154, 840.2857571064596, 840.798208429977, 1167.9532818687253, 29549.40901181978, 29999.400011999773, 30114.54828177579, 41041.0, 41720.58279417205, 41621.79189104058, 42040.57959420405, 42107.0, 42251.57748422515, 42251.57748422515, 7605.125410577772, 7681.731139410136, 7771.689132434696, 7793.883091753628, 7797.7660670179985, 7618.619069046553, 7692.576908270043, 7730.420218483609, 7733.574653394061, 7736.303732664059, 7676.309132178103, 7747.186545412735, 7749.418793590475, 7751.108622508399, 7769.0, 7689.0, 7729.536227826292, 7730.149683534807, 7732.652030658605, 7733.883991740128, 7563.243675632448, 7609.353204977529, 7611.80970475737, 7616.619169041525, 7618.580978046205, 37772.43341349855, 38022.619773802464, 38031.239375212615, 38104.237915241814, 38173.80913095417, 3546.3261980223674, 3573.4997100405963, 3574.571051473814, 3580.337637537038, 3582.444721068239, 31464.685353146404, 31506.212344691565, 31565.36869262625, 31569.368612627848, 31665.52501712476, 4936.827211047632, 4959.231319145538, 4966.807966088113, 4967.950320496821, 4982.526659967298, 192766.0, 193109.24117655956, 194986.0, 195333.0, 195545.0, 47990.5200947993, 48013.5198648009, 48038.0, 48440.75779621079, 48459.75770121127, 51275.48724512782, 51305.7434712824, 51372.48627513752, 51433.22850157251, 51467.7426612872, 14798.778018329735, 14862.70274594502, 16316.918415408085, 16664.75002874958, 16737.246823892954, 13560.728785424237, 13564.186148831102, 13571.86428135706, 13608.0, 13613.455461781417, 14301.642458938402, 14320.785188222186, 14332.856671433361, 14347.641308967359, 14483.275836208148, 5573.414791446839, 5608.1587761835235, 5640.576956728261, 5641.802536911188, 5688.374278829326, 987.9357841740408, 997.9501024948723, 1003.1824063388315, 1005.0602686488157, 1016.6492560066913, 23039.88480057589, 29051.709482905324, 29195.0, 29392.0, 30396.0, 1081.4484612847505, 1085.625459216569, 1087.7171935296722, 1093.971666633362, 1104.867415910096, 12470.189437686522, 15532.92233538825, 15545.922270388575, 15892.443764468188, 16068.75896861548, 224941.0, 225951.0, 225995.0, 226594.0, 227850.0, 56653.0, 56908.715456422455, 57259.0, 57320.42679573235, 57367.42632573621, 1420.4176287721984, 1442.1995792335354, 1443.8267407910907, 1447.0449503327752, 1454.2292584930003, 27362.72637273602, 27544.449111017268, 27982.86008569944, 28195.0, 28225.717742822308, 51181.48818511916, 51901.0, 52100.95798084093, 52107.73946130245, 52258.95482090261, 199723.0, 199765.0, 201370.0, 201639.0, 201785.0, 36309.63690363063, 37329.81335093307, 38003.23993520059, 38020.239595207386, 38056.80971595124, 45474.54525454703, 46169.53830461652, 46192.0, 46343.073138537715, 46639.0, 33741.15647108842, 33968.32063358768, 34204.31591368208, 34334.65665343415, 34578.48132277968, 33312.1671958203, 33588.832055839564, 33683.66316336805, 34009.0, 34342.969710908714, 36508.63491365052, 36642.26715465729, 36806.0, 36879.44680829736, 37622.0, 32329.838350808095, 32469.67530324761, 32627.67372326341, 32939.50590741093, 32939.50590741189, 23859.522809544058, 24022.39944001414, 24110.39724006914, 24770.752292477566, 25182.0], "value": 17740.477247805058, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.9025420551405, 559.9720013999299, 561.2619405481794, 581.3053401185582, 582.2808831093598, 21893.0, 22892.198773042946, 22939.999999999978, 22979.770202297972, 23046.999999999956, 25124.371890702743, 26216.213513594575, 27487.587686184725, 27514.862425687843, 27590.44819103622, 6427.58220715652, 6563.278039415661, 6575.605463672195, 6578.769743058994, 6590.1432813734145, 6050.667213303266, 6353.0788035734795, 6527.086207930894, 6566.310537393552, 6587.703553340088, 6294.55938084332, 6296.496280297565, 6299.811005669837, 6312.33720459352, 6323.841903952415, 6253.187085678833, 6288.622682639033, 6290.779822706229, 6300.621962682254, 6302.464290535287, 5838.357780644125, 5847.2983242010805, 5860.765569377219, 5870.26621672291, 5880.764769409261, 29291.267718307212, 29981.850090749624, 30407.69592304071, 30647.38705225883, 30797.692023079708, 1943.319838056683, 1992.402279316214, 1992.810682985114, 1994.311962372979, 1995.7704863940542, 19020.619587608307, 19348.0, 19674.0, 19702.70445943312, 19703.704444433344, 2408.6868707068143, 2449.497852940143, 2470.7035155781423, 2475.8885850136785, 2491.1530079772783, 141089.0, 147616.99999999892, 148776.0, 149052.0, 149179.0, 14416.351264193136, 15108.169050702318, 15109.320080596399, 15125.924370378078, 15317.463888764063, 23859.403514912265, 23875.761242387354, 23895.283141505784, 23913.52172956566, 23918.880405598207, 9764.462954537568, 9788.755281117887, 9814.165795907285, 10010.599576016877, 10091.49542522871, 8866.77833054166, 8928.419652722552, 8928.955355223183, 9000.279977601776, 9018.09819018093, 8713.0, 9189.586468608928, 9272.258219342437, 9471.763205919908, 9494.905050949541, 2545.567253566898, 2589.9223023309332, 2626.8029897757747, 2632.1313966391044, 2711.9728802712116, 947.5877993073035, 967.8354679704468, 977.63827383867, 984.2126298960802, 991.5934466868694, 20260.493487662927, 20571.868547230046, 20579.279725209544, 20611.0, 20674.896625516776, 1016.7813920007234, 1022.5654097008742, 1029.7837454134565, 1031.9587216511406, 1039.4127318065268, 11330.716732081764, 11431.657050288504, 11457.255278407043, 11459.656210313704, 11597.710057248636, 470098.0, 482419.0, 483082.0, 490085.0, 490764.0, 119787.40106299413, 119891.40054299672, 123216.0, 123261.38369308096, 124237.0, 1220.4934951994824, 1230.1266101068163, 1248.806435002558, 1249.2254802022803, 1250.856151542566, 17766.733498997266, 17950.102494874944, 18143.0, 18297.085145742392, 18367.17347719329, 57387.0, 57558.424415756985, 57676.0, 58327.4167258322, 59811.40188598058, 73033.0, 73168.0, 73199.63400183179, 73570.26429735849, 73865.0, 12419.627411177678, 12891.16207446513, 14492.130472171704, 14700.41198352054, 15214.771778423112, 23639.40901477408, 23669.881650591637, 24131.155409560582, 25164.622530661687, 25325.113621023174, 19402.70895936534, 19570.51073723168, 19715.901420492806, 19787.505312367306, 19855.702164467257, 17099.829001709822, 17386.47840564785, 17487.912560437115, 17860.0, 18311.81688183101, 19579.412617621496, 19945.800541994973, 20064.799352006878, 20091.196352146337, 20183.69724454105, 14954.40182392692, 15102.169380683728, 15184.544463666107, 15386.846131538541, 15391.61520961985, 17443.738343925106, 17451.127443628022, 17466.91266543659, 17470.563235919202, 19055.71416428727], "value": 12092.616245841898, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.5495758920763, 1370.3422357268512, 1376.7384197002566, 1395.4906459142403, 1400.474821941771, 14057.50798722045, 14616.342264598079, 14704.558863234093, 14714.77927831082, 14747.852521474782, 14131.646708832284, 15070.397184112622, 15083.547493575183, 15110.168940708256, 15121.09273443594, 2654.2700757291705, 2710.4714580656682, 2710.864456777163, 2711.6339294195327, 2712.2676877243134, 2549.260714392824, 2571.524268010424, 2607.8565678887653, 2708.702042775293, 2708.79684023699, 2647.245535022519, 2653.668291463567, 2692.2730862667067, 2695.2857492764433, 2695.541757901152, 2575.6780402449785, 2580.883860226285, 2595.4938786936555, 2628.7634112929736, 2628.9868550657316, 2589.8705064746687, 2627.7766389856884, 2628.0670362021588, 2630.3818602628367, 2631.1711810779543, 13969.650758731113, 14384.0, 14421.134731916118, 14423.78364324536, 14424.350904209336, 7398.0, 7589.316961473494, 7629.160792312841, 7646.502977306457, 7652.579108149105, 4919.2129259318335, 5041.521055499722, 5094.77073531692, 5185.818496352609, 5310.787568497255, 1609.1632351177439, 1616.8383161683855, 1663.609051872809, 1667.583104223944, 1675.061965299424, 24676.506469870503, 24807.62788558173, 24820.25539233826, 24862.0, 24958.251252462454, 6248.687565621701, 6523.673816309166, 6525.249596296487, 6680.331966803281, 6697.397234248941, 16266.51200463988, 16291.0, 16302.266398012118, 16304.103274319788, 16329.265183066791, 7612.505187162817, 7738.226177382329, 7740.7677769667, 7746.612669366509, 7765.262300081597, 7076.787696369117, 7168.713251469882, 7232.0, 7274.527155734966, 7295.452841036943, 4967.82612608557, 5096.643234973516, 5130.897382052338, 5141.794328226903, 5167.586593072545, 1333.993330033363, 1362.0533729058407, 1478.3716920308825, 1486.197453375187, 1504.9097054176784, 881.3830318776882, 905.9139381758722, 908.0329449136648, 913.7213149989184, 919.8896132464014, 7896.644650990719, 8246.0, 8252.257296843312, 8293.95853020743, 8385.329173666214, 967.5210770668564, 1004.6684594084081, 1005.5123265216364, 1008.4050410257983, 1009.1976878381704, 4840.201366774443, 5138.640295179302, 5196.688198708014, 5212.218167274939, 5325.281087053276, 19261.422157335302, 20208.0, 20508.487287817625, 20767.273145439838, 20788.58422831535, 19989.500262493555, 20106.497337566678, 20113.99430028493, 20206.0, 20209.191632334838, 9830.655927042662, 10572.947135264274, 10608.946955265328, 10640.733981650521, 10667.19996000303, 8024.197580241929, 8109.837803243784, 8144.429889907887, 8241.381896357678, 8246.628901699558, 17143.742843857603, 17266.65466690684, 17278.13609319504, 17288.22203000843, 17438.82561174372, 17849.643007139526, 17978.460646180636, 18019.639607208046, 18133.546661333574, 18208.45374638763, 10207.7448063799, 10287.279890407599, 10461.424621645883, 10464.424456654957, 10469.790604188025, 12597.43311550964, 12741.426635801596, 12780.0, 12823.679408014874, 12834.037447191311, 8804.911950880409, 10405.21960852924, 10546.894531054591, 10784.892151078702, 10796.0, 10158.0, 10290.639827605997, 10324.22568307395, 10443.791124177322, 10497.685069447929, 9852.0, 9913.206943444651, 10009.349392289478, 10014.198864091, 10018.849717254392, 7248.275172482709, 7251.1298644163035, 7253.455990800817, 7280.453965952681, 7305.3425191732995, 7286.307800758919, 7363.0, 7364.3003914628025, 7404.444666649915, 7528.284812942762], "value": 6422.512046624171, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.4098727527375, 505.25979440120193, 519.3404376441919, 520.7734635433584, 524.2581746828238, 6192.442680158791, 6223.315435302113, 6231.439170474657, 6236.407541283576, 6322.747090116395, 5905.557083218765, 5995.6702381369005, 6038.637681739098, 6095.3599872013465, 6100.816975490731, 4870.391201099854, 4924.901501969958, 4935.5064493550535, 4949.356583644121, 4966.751662416865, 4864.805407783702, 4925.817803727097, 4963.652544321899, 4965.42897566779, 4992.625553083533, 4866.391701037371, 4885.804567817283, 4886.975565122169, 4927.531884470969, 4968.428630707479, 4844.685095468801, 4862.270659401082, 4881.8779530511665, 4886.413630364344, 4950.579200767939, 4380.6276466500385, 4401.185780630593, 4437.556244375569, 4447.799849006802, 4460.174867649495, 6031.276246850362, 6031.849203769897, 6038.124471951586, 6064.696765161724, 6113.419225173601, 5600.4959553639965, 5639.68981706006, 5663.2637757091725, 5663.320401551799, 5683.488486036235, 6391.169148010729, 6403.903941440882, 6448.355164483561, 6467.902981455282, 6545.476361891037, 4848.684835485682, 4848.951510484921, 4857.975710121462, 4871.707697538159, 4901.65688401812, 6842.623655698984, 6859.451243900476, 6859.5541289816, 6873.140857392826, 6948.583085014865, 4948.628852836052, 4972.129877271463, 5003.022597035366, 5006.249062640633, 5019.795249140253, 5048.394192696826, 5072.137736584789, 5084.669496482717, 5094.465081166498, 5121.4622464641425, 5638.295213098363, 5725.8568535786935, 5732.0, 5747.195392645033, 5749.671383089855, 6412.8777463943625, 6548.672566371758, 6554.9672251639395, 6558.442532384801, 6565.277819439858, 1660.418853401324, 1704.7613334132984, 1722.6554689062239, 1749.5713550180033, 1758.7512865865124, 1216.2216181643755, 1218.9817152742717, 1243.2975368916534, 1250.7435975625158, 1254.4229654358915, 5735.799247026334, 5746.166805813134, 5750.0, 5757.395473475225, 5766.798162064308, 6572.474202063823, 6677.933220667828, 6679.699413526403, 6702.151585576208, 6714.227863795726, 5666.829995100154, 5668.234788303526, 5675.886482270332, 5737.598368114275, 5753.223314852525, 3528.400171970771, 3535.469679548088, 3582.6954708849516, 3583.5844841287544, 3584.5877724061547, 6412.551121421549, 6492.64290464029, 6535.451174042128, 6535.797459244935, 6565.967170164214, 6824.7952561423235, 6891.27641597635, 6912.55068420551, 6916.377526022682, 6923.723051078001, 6409.198850143732, 6441.516886233458, 6457.838554036187, 6458.128152699325, 6547.214334279917, 6653.7709867195035, 6686.29793871656, 6742.25835158142, 6757.797266082025, 6774.42417394527, 6654.567453115532, 6681.46548276127, 6683.6324002180345, 6706.6646667665445, 6736.191657001191, 6516.380943810331, 6538.384646141391, 6552.443042341454, 6583.267943803268, 6617.602943823386, 4914.65597408178, 4922.655414120977, 4928.841722195353, 4931.654784165074, 4971.279164521196, 6453.45145662624, 6625.072489851328, 6685.364890335411, 6696.7656132035145, 6718.193816742022, 6241.781537646342, 6373.362663733589, 6427.132337134427, 6454.322296159024, 6500.479961603155, 6380.0, 6393.506532452254, 6417.550771445954, 6469.288378278292, 6511.641859697573, 6301.495880329471, 6321.905171422524, 6328.240611126695, 6340.30256671775, 6350.555461117678, 6451.967740161457, 6459.224893012869, 6470.029495575702, 6508.869822603616, 6509.576877502947, 6265.342139075331, 6295.811125666238, 6311.506954752938, 6332.968335158294, 6337.841553961188], "value": 5024.371277673735, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.1171863292608, 912.5528491039389, 921.3412410126758, 923.5936188077246, 932.5057719408716, 18763.81236187638, 19757.110930008166, 19761.0, 19780.604387912234, 19796.70304945427, 17625.7356139658, 18165.636687266247, 22004.0, 22009.33971980839, 22116.33650990469, 1031.6853359725299, 1044.7858189071221, 1048.8007278617038, 1050.9421981791, 1053.2627160987302, 1008.4134195787817, 1036.2538971940228, 1073.527647834954, 1076.0476977874598, 1076.3004047369195, 1093.5079214353532, 1093.5899037860802, 1096.2819353323587, 1099.2744788439632, 1119.8768135505088, 1086.2342048855537, 1090.2749671468464, 1093.2128867215592, 1094.9945250273777, 1103.4979084516565, 795.8806179073127, 795.9044914610283, 795.932345750612, 800.0599295827379, 816.6814942172557, 18424.355147569906, 18498.2600695972, 18682.906585466986, 18707.34524291643, 20050.398488045383, 21301.68047479289, 21375.786242137536, 21555.67666484988, 21785.237516686997, 21830.45423864416, 15993.20033998307, 16114.597135071599, 16252.268647910872, 16279.0, 16592.502224933272, 3622.0582648511577, 3647.8723244686307, 3649.1424515238896, 3650.7444478886487, 3660.5973342932257, 116647.99999999916, 117797.0, 120601.0, 121764.0, 123536.38231808873, 16812.41156559539, 17414.390496332566, 17488.213030413663, 17499.037552934456, 17747.46757597274, 30627.69372306293, 30710.0, 31404.371912561623, 31419.528707069414, 31428.37143257122, 8543.871841922377, 8612.956935215283, 8613.48319100856, 8632.309415246766, 8655.826883462296, 4166.66666666666, 4237.300845360543, 4241.575842415734, 4242.0, 4248.766317852548, 4637.623367560603, 4779.569838714463, 4787.952120478821, 4791.520847915181, 4811.446683631357, 1020.4795554267378, 1040.4381633917599, 1055.4353420919772, 1058.296233005043, 1059.692689120162, 610.8198081565948, 664.4285914113858, 688.5593220338988, 692.8060143159923, 701.551007355293, 11136.554537818558, 11211.383373914514, 11396.373199474108, 11417.20079594437, 12297.692557686129, 616.1804799616499, 616.8149555133442, 638.0811631250983, 656.7766959233884, 669.5647828911247, 5196.974015129976, 5483.122700367922, 5503.9174412383845, 5542.168674698827, 6005.129256257906, 107322.0, 107735.46132269288, 109987.45006274918, 111948.0, 113657.4317128409, 94424.52787736017, 96090.0, 96606.51696741612, 99666.5016674912, 101529.49235253777, 85859.99999999875, 87637.0, 88385.0, 88511.55744221238, 90840.0, 11094.0, 11262.493187806733, 11560.364179970182, 11957.222780519238, 12166.270023798601, 38716.80641596774, 39884.0, 40400.0, 40590.0, 42074.57925420706, 66806.0, 68339.0, 69950.65024674844, 73594.63202683952, 74153.0, 17662.470125896245, 17721.468355949342, 18054.5486362842, 18128.18423170934, 18186.0, 19806.405807825788, 19949.800501994796, 20187.79812201859, 20218.89890550538, 20439.8978005115, 17439.128043597517, 17575.384861529787, 17612.207450665006, 17699.91150044293, 17917.910410447865, 16634.50096497107, 16744.832551674815, 16839.494815155565, 16987.745183822004, 17000.404985825437, 17756.46730598084, 17988.55028624295, 18011.369602063864, 18032.90983545074, 18118.637627247645, 12580.370981451073, 12653.304068276333, 12826.294553799631, 12839.743205136032, 12859.0, 13535.120217185851, 13771.655708607364, 13858.65353366174, 13940.442382304595, 13958.441662333798], "value": 9093.169870486081, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 113.0, 101.0, 109.0, 107.0, 108.0, 110.0, 99.0, 108.0, 109.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 147.0, 186.0, 119.0, 144.0, 152.0, 119.0, 176.0, 117.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 163.0, 164.0, 162.0, 163.0, 165.0, 167.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 181.0, 77.0, 76.0, 73.0, 75.0, 174.0, 75.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 130.0, 78.0, 78.0, 79.0, 128.0, 79.0, 79.0, 122.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 150.0, 153.0, 151.0, 149.0, 149.0, 149.0, 151.0, 152.0, 151.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 93.0, 95.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 54.0, 58.0, 54.0, 54.0, 53.0, 53.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 57.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 76.0, 77.0, 75.0, 75.0, 82.0, 79.0, 76.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 125.0, 123.0, 124.0, 120.0, 136.0, 137.0, 127.0, 123.0, 166.0], "value": 130.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 196.0, 185.0, 173.0, 171.0, 174.0, 177.0, 172.0, 173.0, 175.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 72.0, 72.0, 68.0, 68.0, 67.0, 69.0, 66.0, 69.0], "value": 69.2, "unit": "score"}]}]} 15:44:40 INFO - Return code: 0 15:44:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:44:40 INFO - # TBPL SUCCESS # 15:44:40 INFO - Running post-action listener: _package_coverage_data 15:44:40 INFO - Running post-action listener: _resource_record_post_action 15:44:40 INFO - [mozharness: 2017-08-21 22:44:40.921781Z] Finished run-tests step (success) 15:44:40 INFO - Running post-run listener: _resource_record_post_run 15:44:41 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 436277248; Read time: 12; Write time: 306464 15:44:41 INFO - TinderboxPrint: CPU usage
13.1% 15:44:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:44:41 INFO - TinderboxPrint: I/O write bytes / time
436,277,248 / 306,464 15:44:41 INFO - TinderboxPrint: CPU idle
8,254.8 (86.9%) 15:44:41 INFO - TinderboxPrint: CPU user
1,198.0 (12.6%) 15:44:41 INFO - TinderboxPrint: Swap in / out
0 / 0 15:44:41 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107311104; Read time: 0; Write time: 66724 15:44:41 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:44:41 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 328966144; Read time: 0; Write time: 239740 15:44:41 INFO - Running post-run listener: _upload_blobber_files 15:44:41 INFO - Blob upload gear active. 15:44:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:44:41 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 15:44:41 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:44:41 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:44:41 INFO - (blobuploader) - INFO - Open directory for files ... 15:44:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:44:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:44:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:42 INFO - (blobuploader) - INFO - Done attempting. 15:44:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:44:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:44:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:43 INFO - (blobuploader) - INFO - Done attempting. 15:44:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:44:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:44:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:50 INFO - (blobuploader) - INFO - Done attempting. 15:44:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:44:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:44:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:50 INFO - (blobuploader) - INFO - Done attempting. 15:44:50 INFO - (blobuploader) - INFO - Iteration through files over. 15:44:50 INFO - Return code: 0 15:44:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:44:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:44:50 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d46c4c456c6377dc6c7df7c76dcbc4c5b3f4db4910061246be1ecfe8084cbf9ba9e199c13aea32645c8e32cc43f4b43061e72a2f342af82976dd50c07f8a5632", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7702a7a93bfacb91850ba1b1cee6304f45bb6299144db64f085054b5570513a285d3a34f616ae51750a6454e5118bfd2825bcec6cb87e558c41be5a3f58e559", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/475ce17b3d3ffd30f635ffda7d9d3d99ec2e93a659c64e525497c786be5df2af5483d5b0aef960c82277feba80fef1754d6777a5341e3137c465b3c074ace8ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c475631b4e00331902d3f7403fa27d60c35e853ef9d2bc759405f876c1ea85a1f63f209ad8cbec55589b44a64cb293ccd426c30f2f0130f86d7d561949d0adce"} 15:44:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:44:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:44:50 INFO - Contents: 15:44:50 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d46c4c456c6377dc6c7df7c76dcbc4c5b3f4db4910061246be1ecfe8084cbf9ba9e199c13aea32645c8e32cc43f4b43061e72a2f342af82976dd50c07f8a5632", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7702a7a93bfacb91850ba1b1cee6304f45bb6299144db64f085054b5570513a285d3a34f616ae51750a6454e5118bfd2825bcec6cb87e558c41be5a3f58e559", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/475ce17b3d3ffd30f635ffda7d9d3d99ec2e93a659c64e525497c786be5df2af5483d5b0aef960c82277feba80fef1754d6777a5341e3137c465b3c074ace8ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c475631b4e00331902d3f7403fa27d60c35e853ef9d2bc759405f876c1ea85a1f63f209ad8cbec55589b44a64cb293ccd426c30f2f0130f86d7d561949d0adce"} 15:44:50 INFO - Running post-run listener: copy_logs_to_upload_dir 15:44:50 INFO - Copying logs to upload dir... 15:44:50 INFO - mkdir: /builds/slave/test/build/upload/logs 15:44:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.544256 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-21 15:44:50.603510) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 15:44:50.610757) ========= 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=836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d46c4c456c6377dc6c7df7c76dcbc4c5b3f4db4910061246be1ecfe8084cbf9ba9e199c13aea32645c8e32cc43f4b43061e72a2f342af82976dd50c07f8a5632", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7702a7a93bfacb91850ba1b1cee6304f45bb6299144db64f085054b5570513a285d3a34f616ae51750a6454e5118bfd2825bcec6cb87e558c41be5a3f58e559", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/475ce17b3d3ffd30f635ffda7d9d3d99ec2e93a659c64e525497c786be5df2af5483d5b0aef960c82277feba80fef1754d6777a5341e3137c465b3c074ace8ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c475631b4e00331902d3f7403fa27d60c35e853ef9d2bc759405f876c1ea85a1f63f209ad8cbec55589b44a64cb293ccd426c30f2f0130f86d7d561949d0adce"} build_url:https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/XiGfkjnVRXmFRNo1aAXTHw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d46c4c456c6377dc6c7df7c76dcbc4c5b3f4db4910061246be1ecfe8084cbf9ba9e199c13aea32645c8e32cc43f4b43061e72a2f342af82976dd50c07f8a5632", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d7702a7a93bfacb91850ba1b1cee6304f45bb6299144db64f085054b5570513a285d3a34f616ae51750a6454e5118bfd2825bcec6cb87e558c41be5a3f58e559", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/475ce17b3d3ffd30f635ffda7d9d3d99ec2e93a659c64e525497c786be5df2af5483d5b0aef960c82277feba80fef1754d6777a5341e3137c465b3c074ace8ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c475631b4e00331902d3f7403fa27d60c35e853ef9d2bc759405f876c1ea85a1f63f209ad8cbec55589b44a64cb293ccd426c30f2f0130f86d7d561949d0adce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 15:44:50.640507) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 15:44:50.640842) ========= 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=836cfdc75598d54cb747368e000001a9-1503353931.12559-1690740153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 15:44:50.693257) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 15:44:50.693599) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 15:44:50.693914) ========= ========= Total master_lag: 0.24 =========