builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1503156740.89 results: success (0) revision: 3dc98e77386986e771f615d8418348adceb65c75 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-19 08:32:20.893374) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-19 08:32:20.893833) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-19 08:32:20.894175) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-19 08:32:20.945870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 08:32:20.946169) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-19 08:32:21-- 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% 15.8M=0.001s 2017-08-19 08:32:21 (15.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096258 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 08:32:21.058115) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 08:32:21.058432) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014672 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 08:32:21.111485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-19 08:32:21.111831) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3dc98e77386986e771f615d8418348adceb65c75 --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 3dc98e77386986e771f615d8418348adceb65c75 --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=7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-19 08:32:21,381 truncating revision to first 12 chars 2017-08-19 08:32:21,381 Setting DEBUG logging. 2017-08-19 08:32:21,381 attempt 1/10 2017-08-19 08:32:21,381 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3dc98e773869?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-19 08:32:22,694 unpacking tar archive at: mozilla-central-3dc98e773869/testing/mozharness/ program finished with exit code 0 elapsedTime=1.699261 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-19 08:32:22.829289) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-19 08:32:22.829943) ========= script_repo_revision: 3dc98e77386986e771f615d8418348adceb65c75 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-19 08:32:22.835572) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-19 08:32:22.836276) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-19 08:32:22.849250) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-19 08:32:22.849962) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:32:23 INFO - MultiFileLogger online at 20170819 08:32:23 in /builds/slave/test 08:32:23 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 08:32:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:32:23 INFO - {'append_to_log': False, 08:32:23 INFO - 'base_work_dir': '/builds/slave/test', 08:32:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:32:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:32:23 INFO - 'branch': 'Firefox-Non-PGO', 08:32:23 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:23 INFO - 'code_coverage': False, 08:32:23 INFO - 'config_files': ('talos/linux_config.py',), 08:32:23 INFO - 'default_actions': ('clobber', 08:32:23 INFO - 'read-buildbot-config', 08:32:23 INFO - 'download-and-extract', 08:32:23 INFO - 'populate-webroot', 08:32:23 INFO - 'create-virtualenv', 08:32:23 INFO - 'install', 08:32:23 INFO - 'setup-mitmproxy', 08:32:23 INFO - 'run-tests'), 08:32:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:23 INFO - 'disable_ccov_upload': False, 08:32:23 INFO - 'download_minidump_stackwalk': True, 08:32:23 INFO - 'download_symbols': 'ondemand', 08:32:23 INFO - 'enable_stylo': False, 08:32:23 INFO - 'enable_webrender': False, 08:32:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:32:23 INFO - 'tooltool.py': '/tools/tooltool.py', 08:32:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:32:23 INFO - '/tools/misc-python/virtualenv.py')}, 08:32:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:23 INFO - 'gecko_profile': False, 08:32:23 INFO - 'gecko_profile_interval': 0, 08:32:23 INFO - 'installer_path': 'installer.exe', 08:32:23 INFO - 'log_level': 'info', 08:32:23 INFO - 'log_name': 'talos', 08:32:23 INFO - 'log_to_console': True, 08:32:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:32:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:32:23 INFO - 'opt_config_files': (), 08:32:23 INFO - 'pip_index': False, 08:32:23 INFO - 'suite': 'dromaeojs-e10s', 08:32:23 INFO - 'system_bits': '32', 08:32:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:23 INFO - 'title': 'talos-linux64-ix-005', 08:32:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:23 INFO - 'use_talos_json': True, 08:32:23 INFO - 'verify': 'False', 08:32:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:32:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:23 INFO - 'work_dir': 'build'} 08:32:23 INFO - [mozharness: 2017-08-19 15:32:23.259969Z] Running clobber step. 08:32:23 INFO - Running pre-action listener: _resource_record_pre_action 08:32:23 INFO - Running main action method: clobber 08:32:23 INFO - rmtree: /builds/slave/test/build 08:32:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:32:24 INFO - Running post-action listener: _resource_record_post_action 08:32:24 INFO - [mozharness: 2017-08-19 15:32:24.803840Z] Finished clobber step (success) 08:32:24 INFO - [mozharness: 2017-08-19 15:32:24.803937Z] Running read-buildbot-config step. 08:32:24 INFO - Running pre-action listener: _resource_record_pre_action 08:32:24 INFO - Running main action method: read_buildbot_config 08:32:24 INFO - Using buildbot properties: 08:32:24 INFO - { 08:32:24 INFO - "project": "", 08:32:24 INFO - "product": "firefox", 08:32:24 INFO - "who": "philringnalda@gmail.com", 08:32:24 INFO - "installer_path": "public/build/target.tar.bz2", 08:32:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:32:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 08:32:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:32:24 INFO - "stage_platform": "linux64", 08:32:24 INFO - "basedir": "/builds/slave/test", 08:32:24 INFO - "buildnumber": 1086, 08:32:24 INFO - "platform": "ubuntu64_hw", 08:32:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:32:24 INFO - "slavebuilddir": "test", 08:32:24 INFO - "taskId": "XdrNAWLRQTiT6Fd0iV7guQ", 08:32:24 INFO - "branch": "mozilla-central", 08:32:24 INFO - "script_repo_revision": "production", 08:32:24 INFO - "revision": "3dc98e77386986e771f615d8418348adceb65c75", 08:32:24 INFO - "slavename": "talos-linux64-ix-005", 08:32:24 INFO - "repo_path": "mozilla-central" 08:32:24 INFO - } 08:32:24 INFO - Finding installer, test and symbols from parent task. 08:32:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XdrNAWLRQTiT6Fd0iV7guQ'}, attempt #1 08:32:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XdrNAWLRQTiT6Fd0iV7guQ'}, attempt #1 08:32:25 INFO - Task dependencies: BQOBZmIbRmqiqlbCbm97Hw 08:32:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw'}, attempt #1 08:32:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.tar.bz2 08:32:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.test_packages.json 08:32:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.crashreporter-symbols.zip 08:32:26 INFO - Running post-action listener: _resource_record_post_action 08:32:26 INFO - [mozharness: 2017-08-19 15:32:26.235450Z] Finished read-buildbot-config step (success) 08:32:26 INFO - [mozharness: 2017-08-19 15:32:26.235755Z] Running download-and-extract step. 08:32:26 INFO - Running pre-action listener: _resource_record_pre_action 08:32:26 INFO - Running main action method: download_and_extract 08:32:26 INFO - mkdir: /builds/slave/test/build/tests 08:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:26 INFO - trying https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.test_packages.json 08:32:26 INFO - Downloading https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:32:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:32:26 INFO - Downloaded 989 bytes. 08:32:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:32:26 INFO - Using the following test package requirements: 08:32:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:32:26 INFO - u'common': [u'target.common.tests.zip'], 08:32:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:32:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:32:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:32:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:32:26 INFO - u'mozbase': [u'target.common.tests.zip'], 08:32:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:32:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:32:26 INFO - u'web-platform': [u'target.common.tests.zip', 08:32:26 INFO - u'target.web-platform.tests.tar.gz'], 08:32:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:32:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:32:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.common.tests.zip 08:32:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:32:26 INFO - Fetch https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.common.tests.zip into memory 08:32:28 INFO - Content-Length response header: 54005087 08:32:28 INFO - Bytes received: 54005087 08:32:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:32:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.common.tests.zip 08:32:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:32:38 INFO - Fetch https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.common.tests.zip into memory 08:32:39 INFO - Content-Length response header: 54005087 08:32:39 INFO - Bytes received: 54005087 08:32:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.talos.tests.zip 08:32:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:32:51 INFO - Fetch https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.talos.tests.zip into memory 08:32:52 INFO - Content-Length response header: 14496256 08:32:52 INFO - Bytes received: 14496256 08:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:52 INFO - trying https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.tar.bz2 08:32:52 INFO - Downloading https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:32:54 INFO - Downloaded 62241283 bytes. 08:32:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.tar.bz2 08:32:54 INFO - mkdir: /builds/slave/test/properties 08:32:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:32:54 INFO - Writing to file /builds/slave/test/properties/build_url 08:32:54 INFO - Contents: 08:32:54 INFO - build_url:https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.tar.bz2 08:32:54 INFO - Running post-action listener: _resource_record_post_action 08:32:54 INFO - Running post-action listener: find_tests_for_verification 08:32:54 INFO - Running post-action listener: set_extra_try_arguments 08:32:54 INFO - [mozharness: 2017-08-19 15:32:54.123012Z] Finished download-and-extract step (success) 08:32:54 INFO - [mozharness: 2017-08-19 15:32:54.123109Z] Running populate-webroot step. 08:32:54 INFO - Running pre-action listener: _resource_record_pre_action 08:32:54 INFO - Running main action method: populate_webroot 08:32:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:32:54 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 08:32:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:32:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:32:54 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 08:32:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:32:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:32:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:54 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:32:54 INFO - 'talos_options': ['--stylo'], 08:32:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:32:54 INFO - 'tests': ['damp', 'tps']}, 08:32:54 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:32:54 INFO - 'talos_options': ['--stylo'], 08:32:54 INFO - 'tests': ['damp', 'tps']}, 08:32:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:32:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:32:54 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 08:32:54 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:32:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:32:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:32:54 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:32:54 INFO - 'talos_options': ['--stylo'], 08:32:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:32:54 INFO - 'other-e10s': {'tests': ['a11yr', 08:32:54 INFO - 'ts_paint', 08:32:54 INFO - 'tpaint', 08:32:54 INFO - 'sessionrestore', 08:32:54 INFO - 'sessionrestore_many_windows', 08:32:54 INFO - 'sessionrestore_no_auto_restore', 08:32:54 INFO - 'tabpaint']}, 08:32:54 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 08:32:54 INFO - 'tests': ['a11yr', 08:32:54 INFO - 'ts_paint', 08:32:54 INFO - 'tpaint', 08:32:54 INFO - 'sessionrestore', 08:32:54 INFO - 'sessionrestore_many_windows', 08:32:54 INFO - 'sessionrestore_no_auto_restore', 08:32:54 INFO - 'tabpaint']}, 08:32:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:32:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:32:54 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 08:32:54 INFO - 'tests': ['bloom_basic_singleton']}, 08:32:54 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 08:32:54 INFO - 'tests': ['bloom_basic']}, 08:32:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:32:54 INFO - 'tsvgr_opacity', 08:32:54 INFO - 'tart', 08:32:54 INFO - 'tscrollx', 08:32:54 INFO - 'tsvg_static']}, 08:32:54 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 08:32:54 INFO - 'tests': ['tsvgx', 08:32:54 INFO - 'tsvgr_opacity', 08:32:54 INFO - 'tart', 08:32:54 INFO - 'tscrollx', 08:32:54 INFO - 'tsvg_static']}, 08:32:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:32:54 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:32:54 INFO - 'talos_options': ['--stylo'], 08:32:54 INFO - 'tests': ['tp5o']}, 08:32:54 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:32:54 INFO - 'talos_options': ['--mitmproxy', 08:32:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:32:54 INFO - '--firstNonBlankPaint'], 08:32:54 INFO - 'tests': ['tp6_google', 08:32:54 INFO - 'tp6_youtube', 08:32:54 INFO - 'tp6_amazon', 08:32:54 INFO - 'tp6_facebook']}, 08:32:54 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:32:54 INFO - 'talos_options': ['--stylo', 08:32:54 INFO - '--mitmproxy', 08:32:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:32:54 INFO - '--firstNonBlankPaint'], 08:32:54 INFO - 'tests': ['tp6_google', 08:32:54 INFO - 'tp6_youtube', 08:32:54 INFO - 'tp6_amazon', 08:32:54 INFO - 'tp6_facebook']}, 08:32:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:32:54 INFO - 'talos_options': ['--stylo', 08:32:54 INFO - '--stylo-threads=1', 08:32:54 INFO - '--mitmproxy', 08:32:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:32:54 INFO - '--firstNonBlankPaint'], 08:32:54 INFO - 'tests': ['tp6_google', 08:32:54 INFO - 'tp6_youtube', 08:32:54 INFO - 'tp6_amazon', 08:32:54 INFO - 'tp6_facebook']}, 08:32:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:32:54 INFO - 'talos_options': ['--xperf_path', 08:32:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:54 INFO - 'tests': ['tp5n']}, 08:32:54 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:32:54 INFO - 'talos_options': ['--stylo', 08:32:54 INFO - '--xperf_path', 08:32:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:54 INFO - 'tests': ['tp5n']}}} 08:32:54 INFO - Running post-action listener: _resource_record_post_action 08:32:54 INFO - [mozharness: 2017-08-19 15:32:54.137228Z] Finished populate-webroot step (success) 08:32:54 INFO - [mozharness: 2017-08-19 15:32:54.137327Z] Running create-virtualenv step. 08:32:54 INFO - Running pre-action listener: _resource_record_pre_action 08:32:54 INFO - Running main action method: create_virtualenv 08:32:54 INFO - Creating virtualenv /builds/slave/test/build/venv 08:32:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:32:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:32:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:32:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:32:54 INFO - Using real prefix '/usr' 08:32:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:32:54 INFO - Installing distribute.............................................................................................................................................................................................done. 08:32:56 INFO - Installing pip.................done. 08:32:56 INFO - Return code: 0 08:32:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:32:56 INFO - Reading from file tmpfile_stdout 08:32:56 INFO - Output received: 08:32:56 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:32:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:32: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')]} 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32: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')]} 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:56 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 0x10ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143a130>, '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 0x143b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:32:56 INFO - Using env: {'DISPLAY': ':0', 08:32:56 INFO - 'HOME': '/home/cltbld', 08:32:56 INFO - 'LANG': 'en_US.UTF-8', 08:32:56 INFO - 'LANGUAGE': 'en_US:en', 08:32:56 INFO - 'LOGNAME': 'cltbld', 08:32:56 INFO - 'MAIL': '/var/mail/cltbld', 08:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:56 INFO - 'MOZ_NO_REMOTE': '1', 08:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:56 INFO - 'NO_EM_RESTART': '1', 08:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:56 INFO - 'PWD': '/builds/slave/test', 08:32:56 INFO - 'SHELL': '/bin/bash', 08:32:56 INFO - 'SHLVL': '1', 08:32:56 INFO - 'TERM': 'linux', 08:32:56 INFO - 'TMOUT': '86400', 08:32:56 INFO - 'USER': 'cltbld', 08:32:56 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 08:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:56 INFO - '_': '/tools/buildbot/bin/python'} 08:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:32:57 INFO - Cleaning up... 08:32:57 INFO - Return code: 0 08:32:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143a130>, '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 0x143b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:32:57 INFO - Using env: {'DISPLAY': ':0', 08:32:57 INFO - 'HOME': '/home/cltbld', 08:32:57 INFO - 'LANG': 'en_US.UTF-8', 08:32:57 INFO - 'LANGUAGE': 'en_US:en', 08:32:57 INFO - 'LOGNAME': 'cltbld', 08:32:57 INFO - 'MAIL': '/var/mail/cltbld', 08:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:57 INFO - 'MOZ_NO_REMOTE': '1', 08:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:57 INFO - 'NO_EM_RESTART': '1', 08:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:57 INFO - 'PWD': '/builds/slave/test', 08:32:57 INFO - 'SHELL': '/bin/bash', 08:32:57 INFO - 'SHLVL': '1', 08:32:57 INFO - 'TERM': 'linux', 08:32:57 INFO - 'TMOUT': '86400', 08:32:57 INFO - 'USER': 'cltbld', 08:32:57 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 08:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:57 INFO - '_': '/tools/buildbot/bin/python'} 08:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:57 INFO - Downloading/unpacking psutil>=3.1.1 08:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:32:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:58 INFO - Installing collected packages: psutil 08:32:58 INFO - Running setup.py install for psutil 08:32:58 INFO - building 'psutil._psutil_linux' extension 08:32:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:32:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:32:58 INFO - building 'psutil._psutil_posix' extension 08:32:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:32:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:32:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:59 INFO - Successfully installed psutil 08:32:59 INFO - Cleaning up... 08:32:59 INFO - Return code: 0 08:32:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:59 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 0x10ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143a130>, '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 0x143b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:32:59 INFO - Using env: {'DISPLAY': ':0', 08:32:59 INFO - 'HOME': '/home/cltbld', 08:32:59 INFO - 'LANG': 'en_US.UTF-8', 08:32:59 INFO - 'LANGUAGE': 'en_US:en', 08:32:59 INFO - 'LOGNAME': 'cltbld', 08:32:59 INFO - 'MAIL': '/var/mail/cltbld', 08:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:59 INFO - 'MOZ_NO_REMOTE': '1', 08:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:59 INFO - 'NO_EM_RESTART': '1', 08:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:59 INFO - 'PWD': '/builds/slave/test', 08:32:59 INFO - 'SHELL': '/bin/bash', 08:32:59 INFO - 'SHLVL': '1', 08:32:59 INFO - 'TERM': 'linux', 08:32:59 INFO - 'TMOUT': '86400', 08:32:59 INFO - 'USER': 'cltbld', 08:32:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 08:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:59 INFO - '_': '/tools/buildbot/bin/python'} 08:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:33:00 INFO - Installing collected packages: mozsystemmonitor 08:33:00 INFO - Running setup.py install for mozsystemmonitor 08:33:00 INFO - Successfully installed mozsystemmonitor 08:33:00 INFO - Cleaning up... 08:33:00 INFO - Return code: 0 08:33:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143a130>, '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 0x143b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:33:00 INFO - Using env: {'DISPLAY': ':0', 08:33:00 INFO - 'HOME': '/home/cltbld', 08:33:00 INFO - 'LANG': 'en_US.UTF-8', 08:33:00 INFO - 'LANGUAGE': 'en_US:en', 08:33:00 INFO - 'LOGNAME': 'cltbld', 08:33:00 INFO - 'MAIL': '/var/mail/cltbld', 08:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:00 INFO - 'MOZ_NO_REMOTE': '1', 08:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:00 INFO - 'NO_EM_RESTART': '1', 08:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:00 INFO - 'PWD': '/builds/slave/test', 08:33:00 INFO - 'SHELL': '/bin/bash', 08:33:00 INFO - 'SHLVL': '1', 08:33:00 INFO - 'TERM': 'linux', 08:33:00 INFO - 'TMOUT': '86400', 08:33:00 INFO - 'USER': 'cltbld', 08:33:00 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 08:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:00 INFO - '_': '/tools/buildbot/bin/python'} 08:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:00 INFO - Downloading/unpacking jsonschema==2.5.1 08:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:33:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:02 INFO - Downloading functools32-3.2.3-2.tar.gz 08:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:33:02 INFO - warning: no files found matching '*.txt' 08:33:02 INFO - no previously-included directories found matching 'build' 08:33:02 INFO - no previously-included directories found matching 'dist' 08:33:02 INFO - no previously-included directories found matching '.git*' 08:33:02 INFO - Installing collected packages: jsonschema, functools32 08:33:02 INFO - Running setup.py install for functools32 08:33:02 INFO - warning: no files found matching '*.txt' 08:33:02 INFO - no previously-included directories found matching 'build' 08:33:02 INFO - no previously-included directories found matching 'dist' 08:33:02 INFO - no previously-included directories found matching '.git*' 08:33:02 INFO - Successfully installed jsonschema functools32 08:33:02 INFO - Cleaning up... 08:33:02 INFO - Return code: 0 08:33:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143a130>, '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 0x143b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:33:02 INFO - Using env: {'DISPLAY': ':0', 08:33:02 INFO - 'HOME': '/home/cltbld', 08:33:02 INFO - 'LANG': 'en_US.UTF-8', 08:33:02 INFO - 'LANGUAGE': 'en_US:en', 08:33:02 INFO - 'LOGNAME': 'cltbld', 08:33:02 INFO - 'MAIL': '/var/mail/cltbld', 08:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:02 INFO - 'MOZ_NO_REMOTE': '1', 08:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:02 INFO - 'NO_EM_RESTART': '1', 08:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:02 INFO - 'PWD': '/builds/slave/test', 08:33:02 INFO - 'SHELL': '/bin/bash', 08:33:02 INFO - 'SHLVL': '1', 08:33:02 INFO - 'TERM': 'linux', 08:33:02 INFO - 'TMOUT': '86400', 08:33:02 INFO - 'USER': 'cltbld', 08:33:02 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 08:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:02 INFO - '_': '/tools/buildbot/bin/python'} 08:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:33:02 INFO - Cleaning up... 08:33:02 INFO - Return code: 0 08:33:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143a130>, '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 0x143b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:33:02 INFO - Using env: {'DISPLAY': ':0', 08:33:02 INFO - 'HOME': '/home/cltbld', 08:33:02 INFO - 'LANG': 'en_US.UTF-8', 08:33:02 INFO - 'LANGUAGE': 'en_US:en', 08:33:02 INFO - 'LOGNAME': 'cltbld', 08:33:02 INFO - 'MAIL': '/var/mail/cltbld', 08:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:02 INFO - 'MOZ_NO_REMOTE': '1', 08:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:02 INFO - 'NO_EM_RESTART': '1', 08:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:02 INFO - 'PWD': '/builds/slave/test', 08:33:02 INFO - 'SHELL': '/bin/bash', 08:33:02 INFO - 'SHLVL': '1', 08:33:02 INFO - 'TERM': 'linux', 08:33:02 INFO - 'TMOUT': '86400', 08:33:02 INFO - 'USER': 'cltbld', 08:33:02 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 08:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:02 INFO - '_': '/tools/buildbot/bin/python'} 08:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:02 INFO - Downloading/unpacking blobuploader==1.2.4 08:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:03 INFO - Downloading blobuploader-1.2.4.tar.gz 08:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:33:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:33:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:04 INFO - Downloading docopt-0.6.1.tar.gz 08:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:33:04 INFO - Installing collected packages: blobuploader, requests, docopt 08:33:04 INFO - Running setup.py install for blobuploader 08:33:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:33:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:33:04 INFO - Running setup.py install for requests 08:33:04 INFO - Running setup.py install for docopt 08:33:04 INFO - Successfully installed blobuploader requests docopt 08:33:04 INFO - Cleaning up... 08:33:05 INFO - Return code: 0 08:33:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:05 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 0x10ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143a130>, '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 0x143b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:33:05 INFO - Using env: {'DISPLAY': ':0', 08:33:05 INFO - 'HOME': '/home/cltbld', 08:33:05 INFO - 'LANG': 'en_US.UTF-8', 08:33:05 INFO - 'LANGUAGE': 'en_US:en', 08:33:05 INFO - 'LOGNAME': 'cltbld', 08:33:05 INFO - 'MAIL': '/var/mail/cltbld', 08:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:05 INFO - 'MOZ_NO_REMOTE': '1', 08:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:05 INFO - 'NO_EM_RESTART': '1', 08:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:05 INFO - 'PWD': '/builds/slave/test', 08:33:05 INFO - 'SHELL': '/bin/bash', 08:33:05 INFO - 'SHLVL': '1', 08:33:05 INFO - 'TERM': 'linux', 08:33:05 INFO - 'TMOUT': '86400', 08:33:05 INFO - 'USER': 'cltbld', 08:33:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 08:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:05 INFO - '_': '/tools/buildbot/bin/python'} 08:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:05 INFO - Running setup.py (path:/tmp/pip-HLFFoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:05 INFO - Running setup.py (path:/tmp/pip-ld4hsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:05 INFO - Running setup.py (path:/tmp/pip-QSlQJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:05 INFO - Running setup.py (path:/tmp/pip-i9WDrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:05 INFO - Running setup.py (path:/tmp/pip-4cPTN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:05 INFO - Running setup.py (path:/tmp/pip-nocahS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:05 INFO - Running setup.py (path:/tmp/pip-DOveBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:05 INFO - Running setup.py (path:/tmp/pip-NvOHcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:05 INFO - Running setup.py (path:/tmp/pip-xLjo0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:05 INFO - Running setup.py (path:/tmp/pip-a_x5MG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:05 INFO - Running setup.py (path:/tmp/pip-DAuecX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:06 INFO - Running setup.py (path:/tmp/pip-CjpVXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:06 INFO - Running setup.py (path:/tmp/pip-3zkwAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:06 INFO - Running setup.py (path:/tmp/pip-CGjEbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:06 INFO - Running setup.py (path:/tmp/pip-uSJIQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:06 INFO - Running setup.py (path:/tmp/pip-1_NRk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:06 INFO - Running setup.py (path:/tmp/pip-SAtBG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:33:06 INFO - Running setup.py install for manifestparser 08:33:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:33:06 INFO - Running setup.py install for mozcrash 08:33:06 INFO - Running setup.py install for mozdebug 08:33:06 INFO - Running setup.py install for mozdevice 08:33:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:33:06 INFO - Running setup.py install for mozfile 08:33:06 INFO - Running setup.py install for mozhttpd 08:33:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:33:07 INFO - Running setup.py install for mozinfo 08:33:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:33:07 INFO - Running setup.py install for mozInstall 08:33:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:33:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:33:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:33:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:33:07 INFO - Running setup.py install for mozleak 08:33:07 INFO - Running setup.py install for mozlog 08:33:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:33:07 INFO - Running setup.py install for moznetwork 08:33:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:33:07 INFO - Running setup.py install for mozprocess 08:33:07 INFO - Running setup.py install for mozprofile 08:33:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:33:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:33:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:33:07 INFO - Running setup.py install for mozrunner 08:33:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:33:07 INFO - Running setup.py install for mozscreenshot 08:33:08 INFO - Running setup.py install for moztest 08:33:08 INFO - Running setup.py install for mozversion 08:33:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:33:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:33:08 INFO - Cleaning up... 08:33:08 INFO - Return code: 0 08:33:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:08 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 0x10ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143a130>, '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 0x143b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:33:08 INFO - Using env: {'DISPLAY': ':0', 08:33:08 INFO - 'HOME': '/home/cltbld', 08:33:08 INFO - 'LANG': 'en_US.UTF-8', 08:33:08 INFO - 'LANGUAGE': 'en_US:en', 08:33:08 INFO - 'LOGNAME': 'cltbld', 08:33:08 INFO - 'MAIL': '/var/mail/cltbld', 08:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:08 INFO - 'MOZ_NO_REMOTE': '1', 08:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:08 INFO - 'NO_EM_RESTART': '1', 08:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:08 INFO - 'PWD': '/builds/slave/test', 08:33:08 INFO - 'SHELL': '/bin/bash', 08:33:08 INFO - 'SHLVL': '1', 08:33:08 INFO - 'TERM': 'linux', 08:33:08 INFO - 'TMOUT': '86400', 08:33:08 INFO - 'USER': 'cltbld', 08:33:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 08:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:08 INFO - '_': '/tools/buildbot/bin/python'} 08:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:08 INFO - Running setup.py (path:/tmp/pip-5zsjbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:08 INFO - Running setup.py (path:/tmp/pip-QrvJbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:08 INFO - Running setup.py (path:/tmp/pip-C_iB00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:08 INFO - Running setup.py (path:/tmp/pip-jCukID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:08 INFO - Running setup.py (path:/tmp/pip-fPzYwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:08 INFO - Running setup.py (path:/tmp/pip-ceVCCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:08 INFO - Running setup.py (path:/tmp/pip-eC6aK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:08 INFO - Running setup.py (path:/tmp/pip-veYkzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:09 INFO - Running setup.py (path:/tmp/pip-hSirQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:09 INFO - Running setup.py (path:/tmp/pip-L4bljx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:09 INFO - Running setup.py (path:/tmp/pip-O43QRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:09 INFO - Running setup.py (path:/tmp/pip-2a9ZY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:09 INFO - Running setup.py (path:/tmp/pip-_czwBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:09 INFO - Running setup.py (path:/tmp/pip-4W8l4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:09 INFO - Running setup.py (path:/tmp/pip-INLxAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:09 INFO - Running setup.py (path:/tmp/pip-yZxuvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:09 INFO - Running setup.py (path:/tmp/pip-JbA_be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:33:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:10 INFO - Downloading blessings-1.6.tar.gz 08:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:33:10 INFO - Installing collected packages: blessings 08:33:10 INFO - Running setup.py install for blessings 08:33:10 INFO - Successfully installed blessings 08:33:10 INFO - Cleaning up... 08:33:11 INFO - Return code: 0 08:33:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:33:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:11 INFO - Reading from file tmpfile_stdout 08:33:11 INFO - Current package versions: 08:33:11 INFO - argparse == 1.2.1 08:33:11 INFO - blessings == 1.6 08:33:11 INFO - blobuploader == 1.2.4 08:33:11 INFO - docopt == 0.6.1 08:33:11 INFO - functools32 == 3.2.3-2 08:33:11 INFO - jsonschema == 2.5.1 08:33:11 INFO - manifestparser == 1.1 08:33:11 INFO - mozInstall == 1.13 08:33:11 INFO - mozcrash == 1.0 08:33:11 INFO - mozdebug == 0.1 08:33:11 INFO - mozdevice == 0.51 08:33:11 INFO - mozfile == 1.2 08:33:11 INFO - mozhttpd == 0.7 08:33:11 INFO - mozinfo == 0.10 08:33:11 INFO - mozleak == 0.1 08:33:11 INFO - mozlog == 3.5 08:33:11 INFO - moznetwork == 0.27 08:33:11 INFO - mozprocess == 0.25 08:33:11 INFO - mozprofile == 0.28 08:33:11 INFO - mozrunner == 6.13 08:33:11 INFO - mozscreenshot == 0.1 08:33:11 INFO - mozsystemmonitor == 0.3 08:33:11 INFO - moztest == 0.8 08:33:11 INFO - mozversion == 1.4 08:33:11 INFO - psutil == 3.1.1 08:33:11 INFO - requests == 1.2.3 08:33:11 INFO - wsgiref == 0.1.2 08:33:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:11 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 0x10ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143a130>, '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 0x143b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:33:11 INFO - Using env: {'DISPLAY': ':0', 08:33:11 INFO - 'HOME': '/home/cltbld', 08:33:11 INFO - 'LANG': 'en_US.UTF-8', 08:33:11 INFO - 'LANGUAGE': 'en_US:en', 08:33:11 INFO - 'LOGNAME': 'cltbld', 08:33:11 INFO - 'MAIL': '/var/mail/cltbld', 08:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:11 INFO - 'MOZ_NO_REMOTE': '1', 08:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:11 INFO - 'NO_EM_RESTART': '1', 08:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:11 INFO - 'PWD': '/builds/slave/test', 08:33:11 INFO - 'SHELL': '/bin/bash', 08:33:11 INFO - 'SHLVL': '1', 08:33:11 INFO - 'TERM': 'linux', 08:33:11 INFO - 'TMOUT': '86400', 08:33:11 INFO - 'USER': 'cltbld', 08:33:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 08:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:11 INFO - '_': '/tools/buildbot/bin/python'} 08:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:33:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:33:12 INFO - Installing collected packages: simplejson 08:33:12 INFO - Running setup.py install for simplejson 08:33:12 INFO - building 'simplejson._speedups' extension 08:33:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 08:33:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 08:33:13 INFO - Successfully installed simplejson 08:33:13 INFO - Cleaning up... 08:33:13 INFO - Return code: 0 08:33:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:13 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 0x10ce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143a130>, '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 0x143b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:33:13 INFO - Using env: {'DISPLAY': ':0', 08:33:13 INFO - 'HOME': '/home/cltbld', 08:33:13 INFO - 'LANG': 'en_US.UTF-8', 08:33:13 INFO - 'LANGUAGE': 'en_US:en', 08:33:13 INFO - 'LOGNAME': 'cltbld', 08:33:13 INFO - 'MAIL': '/var/mail/cltbld', 08:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:13 INFO - 'MOZ_NO_REMOTE': '1', 08:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:13 INFO - 'NO_EM_RESTART': '1', 08:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:13 INFO - 'PWD': '/builds/slave/test', 08:33:13 INFO - 'SHELL': '/bin/bash', 08:33:13 INFO - 'SHLVL': '1', 08:33:13 INFO - 'TERM': 'linux', 08:33:13 INFO - 'TMOUT': '86400', 08:33:13 INFO - 'USER': 'cltbld', 08:33:13 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 08:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:13 INFO - '_': '/tools/buildbot/bin/python'} 08:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:33:13 INFO - Cleaning up... 08:33:13 INFO - Return code: 0 08:33:13 INFO - Running post-action listener: _resource_record_post_action 08:33:13 INFO - Running post-action listener: _start_resource_monitoring 08:33:13 INFO - Starting resource monitoring. 08:33:13 INFO - [mozharness: 2017-08-19 15:33:13.957431Z] Finished create-virtualenv step (success) 08:33:13 INFO - [mozharness: 2017-08-19 15:33:13.957968Z] Running install step. 08:33:13 INFO - Running pre-action listener: _resource_record_pre_action 08:33:13 INFO - Running main action method: install 08:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:14 INFO - Reading from file tmpfile_stdout 08:33:14 INFO - Detecting whether we're running mozinstall >=1.0... 08:33:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:33:14 INFO - Reading from file tmpfile_stdout 08:33:14 INFO - Output received: 08:33:14 INFO - Usage: mozinstall [options] installer 08:33:14 INFO - Options: 08:33:14 INFO - -h, --help show this help message and exit 08:33:14 INFO - -d DEST, --destination=DEST 08:33:14 INFO - Directory to install application into. [default: 08:33:14 INFO - "/builds/slave/test"] 08:33:14 INFO - --app=APP Application being installed. [default: firefox] 08:33:14 INFO - mkdir: /builds/slave/test/build/application 08:33:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:33:32 INFO - Reading from file tmpfile_stdout 08:33:32 INFO - Output received: 08:33:32 INFO - /builds/slave/test/build/application/firefox/firefox 08:33:32 INFO - Running post-action listener: _resource_record_post_action 08:33:32 INFO - [mozharness: 2017-08-19 15:33:32.265899Z] Finished install step (success) 08:33:32 INFO - [mozharness: 2017-08-19 15:33:32.266182Z] Running setup-mitmproxy step. 08:33:32 INFO - Running pre-action listener: _resource_record_pre_action 08:33:32 INFO - Running main action method: setup_mitmproxy 08:33:32 INFO - Skipping: mitmproxy is not required 08:33:32 INFO - Running post-action listener: _resource_record_post_action 08:33:32 INFO - [mozharness: 2017-08-19 15:33:32.267326Z] Finished setup-mitmproxy step (success) 08:33:32 INFO - [mozharness: 2017-08-19 15:33:32.267545Z] Running run-tests step. 08:33:32 INFO - Running pre-action listener: _resource_record_pre_action 08:33:32 INFO - Running pre-action listener: _set_gcov_prefix 08:33:32 INFO - Running main action method: run_tests 08:33:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:33:32 INFO - Python 2.7.3 08:33:32 INFO - Return code: 0 08:33:32 INFO - grabbing minidump binary from tooltool 08:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:32 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 0x143a130>, '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 0x143b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x143b4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:33:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:33:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:33:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:33:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:33:32 INFO - Return code: 0 08:33:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:33:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:33:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:33:32 INFO - ENV: RUST_BACKTRACE is now full 08:33:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:33:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:33:32 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/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:33:32 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/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:33:32 INFO - Using env: {'DISPLAY': ':0', 08:33:32 INFO - 'HOME': '/home/cltbld', 08:33:32 INFO - 'LANG': 'en_US.UTF-8', 08:33:32 INFO - 'LANGUAGE': 'en_US:en', 08:33:32 INFO - 'LOGNAME': 'cltbld', 08:33:32 INFO - 'MAIL': '/var/mail/cltbld', 08:33:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:33:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:32 INFO - 'MOZ_NO_REMOTE': '1', 08:33:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:33:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:32 INFO - 'NO_EM_RESTART': '1', 08:33:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:32 INFO - 'PWD': '/builds/slave/test', 08:33:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:33:32 INFO - 'RUST_BACKTRACE': 'full', 08:33:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:33:32 INFO - 'SHELL': '/bin/bash', 08:33:32 INFO - 'SHLVL': '1', 08:33:32 INFO - 'TERM': 'linux', 08:33:32 INFO - 'TMOUT': '86400', 08:33:32 INFO - 'USER': 'cltbld', 08:33:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577', 08:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:32 INFO - '_': '/tools/buildbot/bin/python'} 08:33:32 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/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:33:32 INFO - mozversion application_buildid: 20170819144808 08:33:32 INFO - mozversion application_changeset: 3dc98e77386986e771f615d8418348adceb65c75 08:33:32 INFO - mozversion application_display_name: Nightly 08:33:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:33:32 INFO - mozversion application_name: Firefox 08:33:32 INFO - mozversion application_remotingname: firefox 08:33:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:33:32 INFO - mozversion application_vendor: Mozilla 08:33:32 INFO - mozversion application_version: 57.0a1 08:33:32 INFO - mozversion platform_buildid: 20170819144808 08:33:32 INFO - mozversion platform_changeset: 3dc98e77386986e771f615d8418348adceb65c75 08:33:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:33:32 INFO - mozversion platform_version: 57.0a1 08:33:32 INFO - using testdate: 1503156812 08:33:32 INFO - actual date: 1503156812 08:33:32 INFO - starting webserver on 'localhost:46927' 08:33:32 INFO - SUITE-START | Running 2 tests 08:33:32 INFO - TEST-START | dromaeo_css 08:33:32 INFO - Initialising browser for dromaeo_css test... 08:33:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46927/getInfo.html -profile /tmp/tmpidhkRk/profile 08:33:32 INFO - TEST-INFO | started process 4156 (/builds/slave/test/build/application/firefox/firefox http://localhost:46927/getInfo.html) 08:33:38 INFO - TEST-INFO | 4156: exit 0 08:33:38 INFO - Browser initialized. 08:33:38 INFO - Running cycle 1/1 for dromaeo_css test... 08:33:38 INFO - TEST-INFO | started process 4374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpidhkRk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:39 INFO - PID 4374 | 08:33:39 INFO - PID 4374 | (/builds/slave/test/build/application/firefox/firefox:4423): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:33:39 INFO - PID 4374 | 08:33:40 INFO - PID 4374 | 08:33:40 INFO - PID 4374 | (/builds/slave/test/build/application/firefox/firefox:4477): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:33:40 INFO - PID 4374 | 08:33:40 INFO - PID 4374 | __metrics Screen width/height:1600/1200 08:33:40 INFO - PID 4374 | colorDepth:24 08:33:40 INFO - PID 4374 | Browser inner width/height: 1024/768 08:33:40 INFO - PID 4374 | __metrics 08:33:49 INFO - PID 4374 | RSS: Main: 172003328 08:33:49 INFO - PID 4374 | 08:36:48 INFO - PID 4374 | Cycle 1(1): loaded http://localhost:46927/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46927/tests/dromaeo/cssquery-ext.html) 08:36:49 INFO - PID 4374 | RSS: Main: 176300032 08:36:49 INFO - PID 4374 | 08:39:51 INFO - PID 4374 | Cycle 1(1): loaded http://localhost:46927/tests/dromaeo/cssquery-ext.html (next: http://localhost:46927/tests/dromaeo/cssquery-jquery.html) 08:39:52 INFO - PID 4374 | RSS: Main: 171991040 08:39:52 INFO - PID 4374 | 08:42:53 INFO - PID 4374 | Cycle 1(1): loaded http://localhost:46927/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46927/tests/dromaeo/cssquery-mootools.html) 08:42:54 INFO - PID 4374 | RSS: Main: 175738880 08:42:54 INFO - PID 4374 | 08:45:56 INFO - PID 4374 | Cycle 1(1): loaded http://localhost:46927/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46927/tests/dromaeo/cssquery-prototype.html) 08:45:56 INFO - PID 4374 | RSS: Main: 173051904 08:45:56 INFO - PID 4374 | 08:49:00 INFO - PID 4374 | Cycle 1(1): loaded http://localhost:46927/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46927/tests/dromaeo/cssquery-yui.html) 08:49:01 INFO - PID 4374 | RSS: Main: 174321664 08:49:01 INFO - PID 4374 | 08:52:02 INFO - PID 4374 | Cycle 1(1): loaded http://localhost:46927/tests/dromaeo/cssquery-yui.html (next: http://localhost:46927/tests/dromaeo/cssquery-dojo.html) 08:52:03 INFO - PID 4374 | RSS: Main: 176898048 08:52:03 INFO - PID 4374 | 08:52:03 INFO - PID 4374 | __start_tp_report 08:52:03 INFO - PID 4374 | _x_x_mozilla_page_load 08:52:03 INFO - PID 4374 | _x_x_mozilla_page_load_details 08:52:03 INFO - PID 4374 | |i|pagename|runs| 08:52:03 INFO - PID 4374 | |0;dojo.html;3152.6374466936295;3176.729977951874;3189.665085166059;3208.31021330414;3211.5664385307978;6243.812685619428;6273.215848018997;6277.340879207686;6311.905321420182;6370.872582548346;6113.7860174893885;6191.876162476748;6204.813855584329;6256.280527739312;6256.530760192993;5702.857428564298;5713.485786279244;5724.398938111501;5759.82720518383;5823.272090988627;5706.514946229555;5781.624194427349;5791.305043394777;5809.157672137538;5863.618864773776;5599.272094627713;5666.235058267163;5717.542596592283;5734.340550836624;5822.7088645567765;5651.350094739117;5686.601937864351;5723.828285151452;5755.539556835443;5781.421857814227;5637.816058627693;5658.801941932013;5731.512821410185;5740.0815869460685;5753.597248192628;6055.878882422371;6098.26820781509;6121.173641558422;6131.325554189036;6217.098520714471;6595.373439523286;6607.504437167232;6618.404343609098;6654.101696271038;6663.966680166568;6710;6743.123393958754;6757.966210168966;6760.459163266927;6765.797026089176;6193.380661933816;6243.968780156116;6277.52918531112;6295.748170073191;6299.842503937347;6861.073755043105;6872.62200578973;6878.931210687829;6953.79138625842;6957.965210174018;6522.412982831568;6541.411272985454;6555.983822507519;6619.768308109193;6627.10534077903;6541.92058310383;6602.60384376939;6649.634270115093;6651.966740166268;6654.900176497356;6550.410463058348;6567.638779867153;6590.934090659128;6592.5055620828625;6602.042703808017;6541.018847172867;6608.041833934052;6621.1392518972225;6624.403803657598;6655.73377064912;5465.617406781566;5482.0406428874785;5497.532709719719;5498.560115190775;5508.55931525477;4605.516420775837;4636.258198688193;4660.86017419478;4670.462896766848;4677.508861569554;5790.449907258888;5800.564957628195;5850.707464626837;5853.239078919713;5882;6569.57297775643;6731.360520750619;6753.054572359873;6765.323467653196;6787.864242715118;5789.913151302734;5799.797007104816;5855.795047173328;5871.207387002785;5880.852978675567;5836.358000619928;5886.58793884424;5900.64596124234;5954.672493012926;5967.522598192134;6512.218533775977;6546.8363290918105;6565.671716414256;6570.244421891448;6572.07990881277;6702.329767023453;6716.865662686817;6742.359475849885;6760.932390676227;6802.319768023356;6448.387403196689;6465.191851018622;6548.934510655023;6557.180352455943;6590.7693230736695;6488.805335839932;6588.472922166311;6596.769113081019;6658.533902626769;6681.933180668131;6656.167979002625;6665.833354166185;6668.06647069401;6686.598804071771;6766.05275261454;6492.935070649233;6617.470602351897;6620.933790662032;6628.038934354588;6632.535722499379;6534.052562378523;6627.966860165669;6642.070110184674;6645.667716614246;6650.035744817072;6469.676516174267;6470.06184103293;6547.901781473377;6570.047343135314;6575.342465753386;6492.253390860112;6544.083828264142;6636.336366363518;6652.434543063894;6662.367075127855;6404.391582799627;6414.711337989708;6427.100205971261;6427.646479443675;6473.902891456538 08:52:03 INFO - PID 4374 | |1;ext.html;833.9666413343466;866.2030931542981;875.081164776984;892.5581836990691;1188.316717887215;31261.062168134937;31721.206969825736;31847.203819904513;42284.57715422852;43420.34869476953;44156.116877662425;44441.77779111108;44518.777406112924;44599.77700111503;44622.77688611561;7653.119891212512;7804.648790804427;7804.80487987802;7807.882881756778;7813.296803287703;7105.8223544411285;7334.376577990877;7658.3873290136935;7661.348785353224;7707.730229441971;7602.657880395395;7672.961635191817;7684.423668224906;7686.423518236126;7687.192844751305;7635.503692259986;7662;7664.923350766505;7666.7316643917475;7681.807954801119;7561.621918904033;7606.3914886808925;7606.543607383574;7611.847763044708;7612.923870761277;38223.426648600296;38441.23117537662;38524.807375963224;38556.22887542262;38567;3565.6969157621375;3601.729870259715;3605.296967091418;3610.4584312353095;3614.34941710492;30497.847510762527;30519.23701907448;30528.08415747509;30550.847245763627;30573.847130764203;4508.413906192174;4559.270516717309;4582.679212455129;4606.792694328763;4673.158831410345;192184;194499;194522;195450;195544.99999999857;48201.276980845316;48433.273500897514;48449.51550484521;48496;48630.513694862595;50775.98448031019;55303.44696553063;55818.44181558213;55941.7202913991;55979.72010139923;16642.833571664127;16756.245968931427;16763.748543771853;16764.664706705797;16771.748423773653;11999.700007499883;13373.598792036255;13607;13612.523561675294;13612.65968350799;13062.804057939138;14607.342669579895;14931.925340373446;14934.626634334229;14966.102033878002;5656.830295091154;5742.339630942495;5775;5899.410058994066;5974.910376344358;991.4101109839634;1001.7846163074973;1024.262530977695;1026.6868605075374;1033.9172866170688;23231.010665413698;23497.882510587337;23704.28887133354;23751.52496950086;23977.130427407872;1088.0642647323295;1089.553283153903;1107.9058280046124;1117.3519358771894;1130.773845230957;12360.381980900918;12502.624921252376;12561.811572826415;12631.431585578672;12690.619281421572;252309;254390;254889;256853;257991;52966;53237.467625324025;53330.99999999922;53448.73275633597;53538.73230633822;1436.8491308412674;1453.6220582648587;1477.697072100217;1480.6668499587722;1508.6077619818707;22769.658455122855;22808;22854.771452285928;22872.771272287064;22945.655815162452;37890.8105459471;38094.238115236985;38100.42849357317;38113.80943095267;38204.6179538201;210822;210903;211089;211419;211579;32587.674123259414;32654;33008;33066;33079;42146.57853421426;42161.156776864904;42229.78885105678;42277.1544569113;42421.884007840046;34980;35089.1227719309;35579.11052223715;35763.284734304645;35944.820275898455;34554;34701.30597388089;34884;34935;35170.29659406746;38361.23277534489;38369.2326153481;38438.42342364923;38768.61231387763;38779.22441551209;33787.4931876027;33963.66036339605;34032.48951265783;34239.48640770341;34666.65333346634;23464.530709385373;24697;24987.250382488553;25054.498910022063;25309.74690253074 08:52:03 INFO - PID 4374 | |2;jquery.html;555.899938011158;560.3807792389412;561.8539179813247;569.2031156381064;584.7310237290847;22134.114635414586;22786.77213227867;22995.885020574875;22997.425064373398;23045.193418230367;26136.869315653395;27174.184774456797;27197.728022719817;27326.180214593594;27338.45323093537;6580.243272023718;6737.157855268091;6745.763898263562;6747.662616869137;6750.966245168767;6179.7837075702355;6490.545661803676;6583.539152259344;6746.426553742937;6785.7964261072;6783.864322713543;6788.355106264897;6793.5584187027935;6795.490338224628;6798.762043328485;6778.254392016875;6781.423578995767;6782.559133656346;6784.253732089466;6784.592924424501;6662.600243985328;6686.1642294713165;6695.430888374494;6696.1629796275465;6697.430718388943;31265.37469250625;32877.50683739746;33290.667093329;33492.49761253583;33599.83200083984;1908.9713654295058;1953.3358658056186;1954.15971132413;1956.7554055743033;1957.5204075001573;20614.969251537364;20954.16183352664;20954.580908381748;21009.264675736275;21042.263520776698;2411.360989337827;2469.592517234654;2491.526609944123;2513.5601269777717;2541.504406640706;139547;145497;148212;148630;148988;19665.8033419664;20812.58374832525;21428;21771.782282177293;22146.889265553567;23712.40718982005;24706.382340441272;24718.876405617855;44954.77522612366;45142.77428612836;10488.4231367274;10492.895071049345;10536;10673.89326106729;10706.357618542912;9746.027461624273;9914.40513569188;9932.950335248277;9986.700398988041;10027.398356098658;9085;9373.109554592304;9427.90572094284;9537;9726.951365243129;2700.8919643214444;2771.80597358183;2782.3600571868583;2823.378856651533;2839.162447078117;913.9725808225763;964.1130160252584;978.5596481583316;981.5975450065439;991.3358050106445;19471.902640486707;19817.60364792696;19917;20264.18943242254;20434.284800031928;1015.1624909449733;1030.953607087683;1039.308859608352;1043.1498328861953;1046.2467023742893;10639.361638301727;10740.677779666623;10893.291936024134;10952.397618131079;11278.436078196057;553832;573922;574957;575329;581052;119946;127842;128063.359683201;128759.35620322026;129848.35075824561;1191.1747447482812;1211.7939950208486;1227.2820400065882;1238.646985609097;1239.324568110382;17220.311187552357;17478.213480393668;17516.474505764847;17550.648987019933;18286.451406457294;55702.72148639231;56806.71596642156;59808.401915982024;60171.39828601658;62629.373706262355;70113.29886701272;70332;70488.29511705022;70789.6460517694;71321;14778.261086945395;15232.314545845686;15290.77063844021;15371.538853834403;15413.768793467883;24256.69561391665;24271.514569708153;24380.6342904853;24529.877350613133;24590.508189835746;18630.906845466227;19115.23539058422;19153.13810878486;19266.614667706286;19274.518137046685;16770.413035543697;17264.223109960334;17309.74035389445;17621.295148193927;17669.116544172997;18879.716804248223;19857.900710496357;19939.501512462306;20178.899105504377;20209.191632334543;14795.852041479879;14977.925110374379;15128.016678915836;15133.394664213749;15139.243037847844;17559.209835557176;17675.204615792063;17682;17815.73276400829;17905.37331193402 08:52:03 INFO - PID 4374 | |3;mootools.html;1310.3382791690199;1338.7389459055476;1347.6630842289428;1351.2162945491616;1370.9862901370984;13989.790153147711;14483;14603.780943285847;14624.707505849876;14734.336954837032;14495.927520362384;14791.112533247986;14807.25963701816;14811.55565333039;14824.332905019273;2589.507993481242;2673.5454972654647;2734.740199681037;2737.069396405222;2742.6297449844315;2701.8649067546644;2745.135282386042;2747.3269049083;2750.188694335176;2752.6421565196497;2680.5175068487665;2708.377073273148;2715.3075965628736;2723.0333231702757;2740.1916434651725;2657.1364306600335;2658.8803503842278;2678.3036410533205;2688.8386696798257;2694.3802925327286;2649.483350746605;2654.15067178501;2668.7598116169443;2670.626112344273;2670.8531030793297;13706.725865482735;14017.31792184934;14031.579052628336;14036;14055.226962517057;7626.694932202705;7726.420518461082;8004.279614834692;8004.759857204293;8019.839603207962;4844.539768722001;5034.4713805050305;5063.620228482879;5119.769610367505;5124.666896651705;1862.37610400516;1890.5368184794677;1929.7973712760238;1960.9313674021485;1965.9901700491405;23291.53416931669;23865.88067059671;23920.282391528282;23946.880265598735;23956.640650390258;6838.111045564145;6879.6216208108035;6955.1653801544135;7037.1555413350725;7094.858102837914;18544.629107417775;18604;18630;18632.44102676922;18638;7846.9215307847335;8004.719834805754;8013.158618345106;8018.71934482302;8026.036875574851;6929.44564434844;7128.28717128283;7131.465140114408;7135.179454362815;7144.3927266182955;5016.874578135503;5166.715830629351;5204.947950520446;5263.473652634706;5270.235815806686;1396.7416028034845;1430.1490613085198;1537.8769698424098;1550.968980620404;1560.9453669121526;888.4358432395476;906.207068814787;912.4890061565544;914.264017465933;918.0498184379136;7788.961055194801;8067.596620168968;8196.713115040944;8206.261436470746;8255.752327430188;991.2862738828032;999.6251405722854;1004.7086344960026;1005.5374527717332;1016.1718199667248;4675.883102922386;5471.917921231185;5520.420355862577;5523.613347065667;5682.914756278659;19834.900825496068;19840.50398740014;20342.898285508476;20513.58972820565;20572.79427205739;20080.297189598296;20278.087486063163;20284.985750712407;20486;20501.48746281325;10054;10247.7438064049;10447.94776026115;10478.895211047944;10501.684949451528;8247.835043298981;8622.568871556272;8789.252913502169;8864.468131912106;8923.598438070172;16826.242819073417;17007.319707211573;17170.570735731708;17178.828211718224;17472.30110795554;17347.219375127897;17428.47714568514;17761.822381776015;17853.107344632976;18067.63864722672;11507.252028618113;11667.941660291644;11795.115366347387;11844.46699898524;11876;13168.802467962796;13317.267550284827;13347.66630834198;13359.666008349868;13374.398152082986;10524.526396312338;10685.252032357972;10744.623938162127;10756.731081722706;10833.729156770829;10249.231307652106;10294.3823370598;10359.32664376813;10555.366677999345;10595.099416549372;9313.720588382359;9701.320907536687;9722.027797220222;9724.367916085715;9785.657501987396;7060;7114.039604653305;7120.359167674727;7129.39400150993;7149.571025738473;7356.117265928123;7370.96314518424;7377.741779037708;7390.889136662847;7432.739854105081 08:52:03 INFO - PID 4374 | |4;prototype.html;494.5217648800711;507.46016188974204;521.1557277210919;521.7782442461954;530.8487081181864;6223.875522489548;6253.7498500060055;6269;6316.368363163687;6343.555951083426;6047.909281360772;6134.815955521331;6144.293406258282;6170.47550958168;6209.472194863442;4905.82829600964;4935.407751069876;4950.381202349707;5019.623528235379;5023.271625614284;4857.951420485785;4943.480934501879;4992.42889911694;5020.171671674169;5022.547970682638;4857.417109946794;4897.436794768611;4912.115819152551;4917.803287868499;4954.628402869781;4946.72792996385;4974.925376119361;4983.501649835024;5005.621205686166;5011.774470148852;4453.131639330332;4480.507144214133;4492.989077457579;4520.593146616788;4523.014810225269;6040.426159514883;6067.787627433063;6104.725287362079;6124.142620033199;6144.556029333103;5777.335606405233;5796.3913789052385;5809.912851307234;5822.7088645567555;5831.125331200312;6514.837129071764;6526.477881769447;6581.30896255891;6588.275289718127;6615.239247486553;4901.2648102784515;4908.190148625473;4915.778789954425;4928.67963582366;4965.428975667808;6821.624810635413;6867.630667419732;6909.1018167637885;6926.549774264657;7029.82075556574;4976.800927962913;5015.27278544609;5017.272495488134;5024.84925452237;5030.320906677625;5089.872753181126;5118.106300668702;5129.435762066169;5130.692158470503;5160.200168973815;5711.457411545896;5757.933018943303;5766.855828604234;5774.884502310014;5819.301683797887;6538.69226154771;6575.145231119924;6606.86786264272;6609.239937407259;6645.102911106938;1649.4062137630444;1674.2214870085224;1710.7262837945868;1723.7761189555556;1762.8012951193311;1199.208522375228;1224.5530381410722;1224.773416917873;1232.4084439469104;1251.6557946564767;5718.771249149988;5790.826275211751;5858.794942177088;5883.941160588425;5899.988008154496;6704.731810727516;6738.7304507819135;6830.316968303229;6862.862742745117;6875.518713690094;5840.620359676607;5844.15259787337;5849.5612829037145;5850.151727999416;5853.180554722342;3623.1123374772824;3624.220792529566;3626.256617393428;3631.727620428426;3640.690541303966;6605.867882642417;6609.86780264392;6630.171228596426;6633.7346506140175;6649.667516624149;7016.2632923543315;7042.6126563039525;7061.611611361424;7065.328793764585;7066.222715501291;6505.316941721146;6510.511711621647;6535;6560.376764207488;6628.602283862983;6732.475321754342;6766.1880574329425;6815.591064536144;6816.659167041727;6870.175578930561;6702.497312701469;6713.765018224339;6763.526553141233;6769.323067693192;6810.9318906810295;6555.147830781968;6638.502112341497;6650.700718467584;6665.833354166185;6684.766033188815;5523.309586301712;5539;5569.888602228014;5638.323401191883;5655.858603534944;6859.211190713132;6943.236244013256;6944.51388402807;6947.340002699735;6951.478639102189;6624.668766561749;6651;6665.800025999034;6667.066610674412;6690.330966903271;6554.672266386567;6581.144451221502;6650.667466626553;6672.933270667425;6687.799366019027;6118.296395914527;6298.622082675054;6374.203224596926;6467.353264673683;6514.990176522647;6575.243846957661;6632.303608121078;6693.531452798452;6693.765718199839;6715.462762978852;6317.273513545817;6384.265809431975;6399.360063993563;6406.423421892052;6473.385028422293 08:52:03 INFO - PID 4374 | |5;yui.html;905.9139381758731;907.5099446298999;925.7407925780775;927.5408672707011;928.4522131942152;18758.90620546897;19439.125239364246;19623;19671.803281967175;21603.45991350217;21147.365579032616;21770.89114554425;21969.23107691231;21995.23016694416;22022.669659955114;1043.446973104254;1068.310939444058;1068.3429690740177;1068.8610480637544;1068.9572417103345;1021.918246540275;1059.1262208677833;1060.5969731502057;1061.6284300494842;1061.7982583309185;1110.3726394587072;1118.9552417903315;1119.1774046076127;1120.1542835159444;1120.3501968858084;1119.776044791041;1121.8092924202906;1123.3316176874746;1124.1961997172061;1125.4485302201945;818.6193420059641;819.1153554161491;820.8522465956125;821.2649678537675;821.5481485183126;19782.109805058808;19953;19967.400977970683;20303.4924126898;20375.286864959802;21304.573908521743;21583.2445864394;21786.346409607737;21816.672749908765;22201.44496387587;16163.83836161635;16436.342546298132;16482.42311519091;16513.83486165135;16581.25384357707;3617.2946275476293;3644.1254099016046;3645.708343332527;3657.6159503252306;3663.0292972362345;110909.44545277303;111875.44062279718;112821.43589282001;113569.43215283954;115739.42130289295;16307.59231019234;16466.75299870503;16989.150542472828;16991.06549139809;16994.150292485327;30156;30804.383912322075;31000.68999309978;31027.224319392197;31051.378972420425;8429.40994130405;8682.218600326001;8700.695475658322;8720.345974051845;8749.081346458657;4171.833126674899;4221.050263690645;4252.659787217077;4272.060146767706;4272.230998420314;4506.662000349987;4859.271109333557;4915.58217551505;4919.385076865392;4921.9507804921495;900.1916249498624;910.4218821048681;920.0661328751323;924.0251534630894;925.8194652042787;702.3398005874461;717.5694583250008;718.1095441652418;720.8125887269348;742.8254360225343;11426.485808138654;11555.76888462226;13727.010637240362;13884.861151388357;13957.371918263703;705.9752908648172;711.6370650968043;712.6650474277081;716.3660160757767;722.0108451421481;5846.532277417797;5929.911051334234;5969.134475501115;6117.632942023492;6180.845478863064;106531;107577.92422075836;109480.71557853278;109645.45177274062;111100;97392;97715;100161.49919250503;102934;103212;80708;82932;83003.16996829954;86949;87590.12409875946;12183.878161218274;12722.109452338247;12812.487500499876;12936.610608020774;13088.345582720636;34858.65141348656;37891.62108378991;39197;40368.798156009034;40583.1883362337;67319;70058;71709;71937.28062719306;72071;19276.783169935636;19905;20067.397978060682;20407.591848162658;20554.38336849897;19996;20060.59878802445;20141.899290503454;20208.292709755675;20306.492337691678;19939;19940.60118797645;19945.800541994395;19977.300794472125;20332.08505617221;15733.527994160193;15736.68526629438;15885.205739712737;15951.122688251793;16051.678966420839;19079.14143863502;19136;19173.90413047926;19582.804171958098;19706.31027914016;13448.596542103753;13627.976101419257;13733.519326823513;14005.579832605039;14100.717985640435;13360.732785344433;13737.450501979809;13799;13920.72158556803;13960.2321872298 08:52:03 INFO - PID 4374 | __end_tp_report 08:52:03 INFO - PID 4374 | __start_cc_report 08:52:03 INFO - PID 4374 | _x_x_mozilla_cycle_collect,371 08:52:03 INFO - PID 4374 | __end_cc_report 08:52:03 INFO - PID 4374 | __startTimestamp1503157923225__endTimestamp 08:52:03 INFO - PID 4374 | 08:52:03 INFO - PID 4374 | ------- Summary: start ------- 08:52:03 INFO - PID 4374 | Number of tests: 6 08:52:03 INFO - PID 4374 | 08:52:03 INFO - PID 4374 | [#0] dojo.html Cycles:165 Average:6173.84 Median:6470.06 stddev:718.71 (11.1%) stddev-sans-first:680.71 08:52:03 INFO - PID 4374 | Values: 3152.6 3176.7 3189.7 3208.3 3211.6 6243.8 6273.2 6277.3 6311.9 6370.9 6113.8 6191.9 6204.8 6256.3 6256.5 5702.9 5713.5 5724.4 5759.8 5823.3 5706.5 5781.6 5791.3 5809.2 5863.6 5599.3 5666.2 5717.5 5734.3 5822.7 5651.4 5686.6 5723.8 5755.5 5781.4 5637.8 5658.8 5731.5 5740.1 5753.6 6055.9 6098.3 6121.2 6131.3 6217.1 6595.4 6607.5 6618.4 6654.1 6664.0 6710.0 6743.1 6758.0 6760.5 6765.8 6193.4 6244.0 6277.5 6295.7 6299.8 6861.1 6872.6 6878.9 6953.8 6958.0 6522.4 6541.4 6556.0 6619.8 6627.1 6541.9 6602.6 6649.6 6652.0 6654.9 6550.4 6567.6 6590.9 6592.5 6602.0 6541.0 6608.0 6621.1 6624.4 6655.7 5465.6 5482.0 5497.5 5498.6 5508.6 4605.5 4636.3 4660.9 4670.5 4677.5 5790.4 5800.6 5850.7 5853.2 5882.0 6569.6 6731.4 6753.1 6765.3 6787.9 5789.9 5799.8 5855.8 5871.2 5880.9 5836.4 5886.6 5900.6 5954.7 5967.5 6512.2 6546.8 6565.7 6570.2 6572.1 6702.3 6716.9 6742.4 6760.9 6802.3 6448.4 6465.2 6548.9 6557.2 6590.8 6488.8 6588.5 6596.8 6658.5 6681.9 6656.2 6665.8 6668.1 6686.6 6766.1 6492.9 6617.5 6620.9 6628.0 6632.5 6534.1 6628.0 6642.1 6645.7 6650.0 6469.7 6470.1 6547.9 6570.0 6575.3 6492.3 6544.1 6636.3 6652.4 6662.4 6404.4 6414.7 6427.1 6427.6 6473.9 08:52:03 INFO - PID 4374 | 08:52:03 INFO - PID 4374 | [#1] ext.html Cycles:180 Average:39114.29 Median:19572.40 stddev:57589.09 (294.2%) stddev-sans-first:57678.91 08:52:03 INFO - PID 4374 | Values: 834.0 866.2 875.1 892.6 1188.3 31261.1 31721.2 31847.2 42284.6 43420.3 44156.1 44441.8 44518.8 44599.8 44622.8 7653.1 7804.6 7804.8 7807.9 7813.3 7105.8 7334.4 7658.4 7661.3 7707.7 7602.7 7673.0 7684.4 7686.4 7687.2 7635.5 7662.0 7664.9 7666.7 7681.8 7561.6 7606.4 7606.5 7611.8 7612.9 38223.4 38441.2 38524.8 38556.2 38567.0 3565.7 3601.7 3605.3 3610.5 3614.3 30497.8 30519.2 30528.1 30550.8 30573.8 4508.4 4559.3 4582.7 4606.8 4673.2 192184.0 194499.0 194522.0 195450.0 195545.0 48201.3 48433.3 48449.5 48496.0 48630.5 50776.0 55303.4 55818.4 55941.7 55979.7 16642.8 16756.2 16763.7 16764.7 16771.7 11999.7 13373.6 13607.0 13612.5 13612.7 13062.8 14607.3 14931.9 14934.6 14966.1 5656.8 5742.3 5775.0 5899.4 5974.9 991.4 1001.8 1024.3 1026.7 1033.9 23231.0 23497.9 23704.3 23751.5 23977.1 1088.1 1089.6 1107.9 1117.4 1130.8 12360.4 12502.6 12561.8 12631.4 12690.6 252309.0 254390.0 254889.0 256853.0 257991.0 52966.0 53237.5 53331.0 53448.7 53538.7 1436.8 1453.6 1477.7 1480.7 1508.6 22769.7 22808.0 22854.8 22872.8 22945.7 37890.8 38094.2 38100.4 38113.8 38204.6 210822.0 210903.0 211089.0 211419.0 211579.0 32587.7 32654.0 33008.0 33066.0 33079.0 42146.6 42161.2 42229.8 42277.2 42421.9 34980.0 35089.1 35579.1 35763.3 35944.8 34554.0 34701.3 34884.0 34935.0 35170.3 38361.2 38369.2 38438.4 38768.6 38779.2 33787.5 33963.7 34032.5 34239.5 34666.7 23464.5 24697.0 24987.3 25054.5 25309.7 08:52:03 INFO - PID 4374 | 08:52:03 INFO - PID 4374 | [#2] jquery.html Cycles:180 Average:38431.91 Median:23378.80 stddev:95725.49 (409.5%) stddev-sans-first:95951.79 08:52:03 INFO - PID 4374 | Values: 555.9 560.4 561.9 569.2 584.7 22134.1 22786.8 22995.9 22997.4 23045.2 26136.9 27174.2 27197.7 27326.2 27338.5 6580.2 6737.2 6745.8 6747.7 6751.0 6179.8 6490.5 6583.5 6746.4 6785.8 6783.9 6788.4 6793.6 6795.5 6798.8 6778.3 6781.4 6782.6 6784.3 6784.6 6662.6 6686.2 6695.4 6696.2 6697.4 31265.4 32877.5 33290.7 33492.5 33599.8 1909.0 1953.3 1954.2 1956.8 1957.5 20615.0 20954.2 20954.6 21009.3 21042.3 2411.4 2469.6 2491.5 2513.6 2541.5 139547.0 145497.0 148212.0 148630.0 148988.0 19665.8 20812.6 21428.0 21771.8 22146.9 23712.4 24706.4 24718.9 44954.8 45142.8 10488.4 10492.9 10536.0 10673.9 10706.4 9746.0 9914.4 9933.0 9986.7 10027.4 9085.0 9373.1 9427.9 9537.0 9727.0 2700.9 2771.8 2782.4 2823.4 2839.2 914.0 964.1 978.6 981.6 991.3 19471.9 19817.6 19917.0 20264.2 20434.3 1015.2 1031.0 1039.3 1043.1 1046.2 10639.4 10740.7 10893.3 10952.4 11278.4 553832.0 573922.0 574957.0 575329.0 581052.0 119946.0 127842.0 128063.4 128759.4 129848.4 1191.2 1211.8 1227.3 1238.6 1239.3 17220.3 17478.2 17516.5 17550.6 18286.5 55702.7 56806.7 59808.4 60171.4 62629.4 70113.3 70332.0 70488.3 70789.6 71321.0 14778.3 15232.3 15290.8 15371.5 15413.8 24256.7 24271.5 24380.6 24529.9 24590.5 18630.9 19115.2 19153.1 19266.6 19274.5 16770.4 17264.2 17309.7 17621.3 17669.1 18879.7 19857.9 19939.5 20178.9 20209.2 14795.9 14977.9 15128.0 15133.4 15139.2 17559.2 17675.2 17682.0 17815.7 17905.4 08:52:03 INFO - PID 4374 | 08:52:03 INFO - PID 4374 | [#3] mootools.html Cycles:180 Average:9002.98 Median:2655.64 stddev:6214.63 (234.0%) stddev-sans-first:6205.18 08:52:03 INFO - PID 4374 | Values: 1310.3 1338.7 1347.7 1351.2 1371.0 13989.8 14483.0 14603.8 14624.7 14734.3 14495.9 14791.1 14807.3 14811.6 14824.3 2589.5 2673.5 2734.7 2737.1 2742.6 2701.9 2745.1 2747.3 2750.2 2752.6 2680.5 2708.4 2715.3 2723.0 2740.2 2657.1 2658.9 2678.3 2688.8 2694.4 2649.5 2654.2 2668.8 2670.6 2670.9 13706.7 14017.3 14031.6 14036.0 14055.2 7626.7 7726.4 8004.3 8004.8 8019.8 4844.5 5034.5 5063.6 5119.8 5124.7 1862.4 1890.5 1929.8 1960.9 1966.0 23291.5 23865.9 23920.3 23946.9 23956.6 6838.1 6879.6 6955.2 7037.2 7094.9 18544.6 18604.0 18630.0 18632.4 18638.0 7846.9 8004.7 8013.2 8018.7 8026.0 6929.4 7128.3 7131.5 7135.2 7144.4 5016.9 5166.7 5204.9 5263.5 5270.2 1396.7 1430.1 1537.9 1551.0 1560.9 888.4 906.2 912.5 914.3 918.0 7789.0 8067.6 8196.7 8206.3 8255.8 991.3 999.6 1004.7 1005.5 1016.2 4675.9 5471.9 5520.4 5523.6 5682.9 19834.9 19840.5 20342.9 20513.6 20572.8 20080.3 20278.1 20285.0 20486.0 20501.5 10054.0 10247.7 10447.9 10478.9 10501.7 8247.8 8622.6 8789.3 8864.5 8923.6 16826.2 17007.3 17170.6 17178.8 17472.3 17347.2 17428.5 17761.8 17853.1 18067.6 11507.3 11667.9 11795.1 11844.5 11876.0 13168.8 13317.3 13347.7 13359.7 13374.4 10524.5 10685.3 10744.6 10756.7 10833.7 10249.2 10294.4 10359.3 10555.4 10595.1 9313.7 9701.3 9722.0 9724.4 9785.7 7060.0 7114.0 7120.4 7129.4 7149.6 7356.1 7371.0 7377.7 7390.9 7432.7 08:52:03 INFO - PID 4374 | 08:52:03 INFO - PID 4374 | [#4] prototype.html Cycles:180 Average:5575.95 Median:6129.48 stddev:1571.99 (25.6%) stddev-sans-first:1529.43 08:52:03 INFO - PID 4374 | Values: 494.5 507.5 521.2 521.8 530.8 6223.9 6253.7 6269.0 6316.4 6343.6 6047.9 6134.8 6144.3 6170.5 6209.5 4905.8 4935.4 4950.4 5019.6 5023.3 4858.0 4943.5 4992.4 5020.2 5022.5 4857.4 4897.4 4912.1 4917.8 4954.6 4946.7 4974.9 4983.5 5005.6 5011.8 4453.1 4480.5 4493.0 4520.6 4523.0 6040.4 6067.8 6104.7 6124.1 6144.6 5777.3 5796.4 5809.9 5822.7 5831.1 6514.8 6526.5 6581.3 6588.3 6615.2 4901.3 4908.2 4915.8 4928.7 4965.4 6821.6 6867.6 6909.1 6926.5 7029.8 4976.8 5015.3 5017.3 5024.8 5030.3 5089.9 5118.1 5129.4 5130.7 5160.2 5711.5 5757.9 5766.9 5774.9 5819.3 6538.7 6575.1 6606.9 6609.2 6645.1 1649.4 1674.2 1710.7 1723.8 1762.8 1199.2 1224.6 1224.8 1232.4 1251.7 5718.8 5790.8 5858.8 5883.9 5900.0 6704.7 6738.7 6830.3 6862.9 6875.5 5840.6 5844.2 5849.6 5850.2 5853.2 3623.1 3624.2 3626.3 3631.7 3640.7 6605.9 6609.9 6630.2 6633.7 6649.7 7016.3 7042.6 7061.6 7065.3 7066.2 6505.3 6510.5 6535.0 6560.4 6628.6 6732.5 6766.2 6815.6 6816.7 6870.2 6702.5 6713.8 6763.5 6769.3 6810.9 6555.1 6638.5 6650.7 6665.8 6684.8 5523.3 5539.0 5569.9 5638.3 5655.9 6859.2 6943.2 6944.5 6947.3 6951.5 6624.7 6651.0 6665.8 6667.1 6690.3 6554.7 6581.1 6650.7 6672.9 6687.8 6118.3 6298.6 6374.2 6467.4 6515.0 6575.2 6632.3 6693.5 6693.8 6715.5 6317.3 6384.3 6399.4 6406.4 6473.4 08:52:03 INFO - PID 4374 | 08:52:03 INFO - PID 4374 | [#5] yui.html Cycles:180 Average:23539.26 Median:20255.89 stddev:30946.79 (152.8%) stddev-sans-first:30986.94 08:52:03 INFO - PID 4374 | Values: 905.9 907.5 925.7 927.5 928.5 18758.9 19439.1 19623.0 19671.8 21603.5 21147.4 21770.9 21969.2 21995.2 22022.7 1043.4 1068.3 1068.3 1068.9 1069.0 1021.9 1059.1 1060.6 1061.6 1061.8 1110.4 1119.0 1119.2 1120.2 1120.4 1119.8 1121.8 1123.3 1124.2 1125.4 818.6 819.1 820.9 821.3 821.5 19782.1 19953.0 19967.4 20303.5 20375.3 21304.6 21583.2 21786.3 21816.7 22201.4 16163.8 16436.3 16482.4 16513.8 16581.3 3617.3 3644.1 3645.7 3657.6 3663.0 110909.4 111875.4 112821.4 113569.4 115739.4 16307.6 16466.8 16989.2 16991.1 16994.2 30156.0 30804.4 31000.7 31027.2 31051.4 8429.4 8682.2 8700.7 8720.3 8749.1 4171.8 4221.1 4252.7 4272.1 4272.2 4506.7 4859.3 4915.6 4919.4 4922.0 900.2 910.4 920.1 924.0 925.8 702.3 717.6 718.1 720.8 742.8 11426.5 11555.8 13727.0 13884.9 13957.4 706.0 711.6 712.7 716.4 722.0 5846.5 5929.9 5969.1 6117.6 6180.8 106531.0 107577.9 109480.7 109645.5 111100.0 97392.0 97715.0 100161.5 102934.0 103212.0 80708.0 82932.0 83003.2 86949.0 87590.1 12183.9 12722.1 12812.5 12936.6 13088.3 34858.7 37891.6 39197.0 40368.8 40583.2 67319.0 70058.0 71709.0 71937.3 72071.0 19276.8 19905.0 20067.4 20407.6 20554.4 19996.0 20060.6 20141.9 20208.3 20306.5 19939.0 19940.6 19945.8 19977.3 20332.1 15733.5 15736.7 15885.2 15951.1 16051.7 19079.1 19136.0 19173.9 19582.8 19706.3 13448.6 13628.0 13733.5 14005.6 14100.7 13360.7 13737.5 13799.0 13920.7 13960.2 08:52:03 INFO - PID 4374 | -------- Summary: end -------- 08:52:03 INFO - PID 4374 | 08:52:03 INFO - TEST-INFO | 4374: exit 0 08:52:03 INFO - TEST-OK | dromaeo_css | took 1111324ms 08:52:03 INFO - TEST-START | kraken 08:52:03 INFO - Initialising browser for kraken test... 08:52:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46927/getInfo.html -profile /tmp/tmpFtUy_S/profile 08:52:03 INFO - TEST-INFO | started process 4786 (/builds/slave/test/build/application/firefox/firefox http://localhost:46927/getInfo.html) 08:52:09 INFO - TEST-INFO | 4786: exit 0 08:52:09 INFO - Browser initialized. 08:52:09 INFO - Running cycle 1/1 for kraken test... 08:52:09 INFO - TEST-INFO | started process 4961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFtUy_S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:10 INFO - PID 4961 | 08:52:10 INFO - PID 4961 | (/builds/slave/test/build/application/firefox/firefox:5010): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:52:10 INFO - PID 4961 | 08:52:11 INFO - PID 4961 | 08:52:11 INFO - PID 4961 | (/builds/slave/test/build/application/firefox/firefox:5065): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:52:11 INFO - PID 4961 | 08:52:11 INFO - PID 4961 | __metrics Screen width/height:1600/1200 08:52:11 INFO - PID 4961 | colorDepth:24 08:52:11 INFO - PID 4961 | Browser inner width/height: 1024/768 08:52:11 INFO - PID 4961 | __metrics 08:52:20 INFO - PID 4961 | RSS: Main: 171753472 08:52:20 INFO - PID 4961 | 08:52:23 INFO - PID 4961 | Cycle 1(1): loaded http://localhost:46927/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46927/tests/kraken/driver.html?testName=audio-beat-detection) 08:52:24 INFO - PID 4961 | RSS: Main: 175779840 08:52:24 INFO - PID 4961 | 08:52:27 INFO - PID 4961 | Cycle 1(1): loaded http://localhost:46927/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46927/tests/kraken/driver.html?testName=audio-dft) 08:52:27 INFO - PID 4961 | RSS: Main: 178049024 08:52:27 INFO - PID 4961 | 08:52:30 INFO - PID 4961 | Cycle 1(1): loaded http://localhost:46927/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46927/tests/kraken/driver.html?testName=audio-fft) 08:52:31 INFO - PID 4961 | RSS: Main: 172023808 08:52:31 INFO - PID 4961 | 08:52:33 INFO - PID 4961 | Cycle 1(1): loaded http://localhost:46927/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46927/tests/kraken/driver.html?testName=audio-oscillator) 08:52:34 INFO - PID 4961 | RSS: Main: 171859968 08:52:34 INFO - PID 4961 | 08:52:36 INFO - PID 4961 | Cycle 1(1): loaded http://localhost:46927/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46927/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:52:36 INFO - PID 4961 | RSS: Main: 173031424 08:52:36 INFO - PID 4961 | 08:52:39 INFO - PID 4961 | Cycle 1(1): loaded http://localhost:46927/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46927/tests/kraken/driver.html?testName=imaging-darkroom) 08:52:40 INFO - PID 4961 | RSS: Main: 173723648 08:52:40 INFO - PID 4961 | 08:52:43 INFO - PID 4961 | Cycle 1(1): loaded http://localhost:46927/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46927/tests/kraken/driver.html?testName=imaging-desaturate) 08:52:44 INFO - PID 4961 | RSS: Main: 174845952 08:52:44 INFO - PID 4961 | 08:52:47 INFO - PID 4961 | Cycle 1(1): loaded http://localhost:46927/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46927/tests/kraken/driver.html?testName=json-parse-financial) 08:52:48 INFO - PID 4961 | RSS: Main: 174444544 08:52:48 INFO - PID 4961 | 08:52:49 INFO - PID 4961 | Cycle 1(1): loaded http://localhost:46927/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46927/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:52:50 INFO - PID 4961 | RSS: Main: 174026752 08:52:50 INFO - PID 4961 | 08:52:52 INFO - PID 4961 | Cycle 1(1): loaded http://localhost:46927/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46927/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:52:52 INFO - PID 4961 | RSS: Main: 173907968 08:52:52 INFO - PID 4961 | 08:52:54 INFO - PID 4961 | Cycle 1(1): loaded http://localhost:46927/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46927/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:52:55 INFO - PID 4961 | RSS: Main: 174149632 08:52:55 INFO - PID 4961 | 08:52:58 INFO - PID 4961 | Cycle 1(1): loaded http://localhost:46927/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:52:58 INFO - PID 4961 | RSS: Main: 174538752 08:52:58 INFO - PID 4961 | 08:53:01 INFO - PID 4961 | Cycle 1(1): loaded http://localhost:46927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:53:02 INFO - PID 4961 | RSS: Main: 174665728 08:53:02 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | Cycle 1(1): loaded http://localhost:46927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46927/tests/kraken/driver.html?testName=ai-astar) 08:53:04 INFO - PID 4961 | RSS: Main: 176017408 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | __start_tp_report 08:53:04 INFO - PID 4961 | _x_x_mozilla_page_load 08:53:04 INFO - PID 4961 | _x_x_mozilla_page_load_details 08:53:04 INFO - PID 4961 | |i|pagename|runs| 08:53:04 INFO - PID 4961 | |0;ai-astar;98;115;101;109;110;111;108;99;107;109 08:53:04 INFO - PID 4961 | |1;audio-beat-detection;153;119;141;166;117;141;147;117;174;121 08:53:04 INFO - PID 4961 | |2;audio-dft;164;163;162;163;163;166;165;169;169;162 08:53:04 INFO - PID 4961 | |3;audio-fft;76;75;74;174;80;76;75;74;161;76 08:53:04 INFO - PID 4961 | |4;audio-oscillator;78;78;130;78;79;79;134;78;78;124 08:53:04 INFO - PID 4961 | |5;imaging-gaussian-blur;115;115;114;114;114;114;118;118;117;115 08:53:04 INFO - PID 4961 | |6;imaging-darkroom;149;150;151;150;150;150;151;150;149;150 08:53:04 INFO - PID 4961 | |7;imaging-desaturate;94;94;94;94;94;93;94;96;94;98 08:53:04 INFO - PID 4961 | |8;json-parse-financial;58;58;53;52;53;54;54;54;53;53 08:53:04 INFO - PID 4961 | |9;json-stringify-tinderbox;55;55;55;54;55;54;55;56;56;55 08:53:04 INFO - PID 4961 | |10;stanford-crypto-aes;81;75;75;74;74;73;74;75;75;76 08:53:04 INFO - PID 4961 | |11;stanford-crypto-ccm;122;121;134;122;127;121;120;119;121;156 08:53:04 INFO - PID 4961 | |12;stanford-crypto-pbkdf2;175;168;179;176;171;170;173;175;168;176 08:53:04 INFO - PID 4961 | |13;stanford-crypto-sha256-iterative;70;69;69;67;70;69;68;66;65;65 08:53:04 INFO - PID 4961 | __end_tp_report 08:53:04 INFO - PID 4961 | __start_cc_report 08:53:04 INFO - PID 4961 | _x_x_mozilla_cycle_collect,985 08:53:04 INFO - PID 4961 | __end_cc_report 08:53:04 INFO - PID 4961 | __startTimestamp1503157984461__endTimestamp 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | ------- Summary: start ------- 08:53:04 INFO - PID 4961 | Number of tests: 14 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | [#0] ai-astar Cycles:10 Average:106.70 Median:110.50 stddev:5.56 (5.0%) stddev-sans-first:4.92 08:53:04 INFO - PID 4961 | Values: 98.0 115.0 101.0 109.0 110.0 111.0 108.0 99.0 107.0 109.0 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:144.00 stddev:20.84 (14.5%) stddev-sans-first:21.54 08:53:04 INFO - PID 4961 | Values: 153.0 119.0 141.0 166.0 117.0 141.0 147.0 117.0 174.0 121.0 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:2.63 (1.6%) stddev-sans-first:2.78 08:53:04 INFO - PID 4961 | Values: 164.0 163.0 162.0 163.0 163.0 166.0 165.0 169.0 169.0 162.0 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.50 stddev:38.84 (51.4%) stddev-sans-first:40.64 08:53:04 INFO - PID 4961 | Values: 76.0 75.0 74.0 174.0 80.0 76.0 75.0 74.0 161.0 76.0 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:78.00 stddev:24.78 (31.8%) stddev-sans-first:25.63 08:53:04 INFO - PID 4961 | Values: 78.0 78.0 130.0 78.0 79.0 79.0 134.0 78.0 78.0 124.0 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:1.65 (1.4%) stddev-sans-first:1.74 08:53:04 INFO - PID 4961 | Values: 115.0 115.0 114.0 114.0 114.0 114.0 118.0 118.0 117.0 115.0 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | [#6] imaging-darkroom Cycles:10 Average:150.00 Median:150.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 08:53:04 INFO - PID 4961 | Values: 149.0 150.0 151.0 150.0 150.0 150.0 151.0 150.0 149.0 150.0 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.43 (1.5%) stddev-sans-first:1.51 08:53:04 INFO - PID 4961 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 94.0 96.0 94.0 98.0 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:2.10 (3.9%) stddev-sans-first:1.72 08:53:04 INFO - PID 4961 | Values: 58.0 58.0 53.0 52.0 53.0 54.0 54.0 54.0 53.0 53.0 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 08:53:04 INFO - PID 4961 | Values: 55.0 55.0 55.0 54.0 55.0 54.0 55.0 56.0 56.0 55.0 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:2.20 (2.9%) stddev-sans-first:0.88 08:53:04 INFO - PID 4961 | Values: 81.0 75.0 75.0 74.0 74.0 73.0 74.0 75.0 75.0 76.0 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:122.00 stddev:11.33 (9.3%) stddev-sans-first:11.91 08:53:04 INFO - PID 4961 | Values: 122.0 121.0 134.0 122.0 127.0 121.0 120.0 119.0 121.0 156.0 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:175.00 stddev:3.73 (2.1%) stddev-sans-first:3.89 08:53:04 INFO - PID 4961 | Values: 175.0 168.0 179.0 176.0 171.0 170.0 173.0 175.0 168.0 176.0 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:69.00 stddev:1.93 (2.8%) stddev-sans-first:1.88 08:53:04 INFO - PID 4961 | Values: 70.0 69.0 69.0 67.0 70.0 69.0 68.0 66.0 65.0 65.0 08:53:04 INFO - PID 4961 | -------- Summary: end -------- 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 08:53:04 INFO - PID 4961 | 08:53:04 INFO - PID 4961 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:53:05 INFO - TEST-INFO | 4961: exit 0 08:53:05 INFO - TEST-OK | kraken | took 61233ms 08:53:05 INFO - SUITE-END | took 1172s 08:53:05 INFO - Completed test suite (00:19:32) 08:53:05 INFO - javascript benchmark 08:53:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8644.195072886132, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3152.6374466936295, 3176.729977951874, 3189.665085166059, 3208.31021330414, 3211.5664385307978, 6243.812685619428, 6273.215848018997, 6277.340879207686, 6311.905321420182, 6370.872582548346, 6113.7860174893885, 6191.876162476748, 6204.813855584329, 6256.280527739312, 6256.530760192993, 5702.857428564298, 5713.485786279244, 5724.398938111501, 5759.82720518383, 5823.272090988627, 5706.514946229555, 5781.624194427349, 5791.305043394777, 5809.157672137538, 5863.618864773776, 5599.272094627713, 5666.235058267163, 5717.542596592283, 5734.340550836624, 5822.7088645567765, 5651.350094739117, 5686.601937864351, 5723.828285151452, 5755.539556835443, 5781.421857814227, 5637.816058627693, 5658.801941932013, 5731.512821410185, 5740.0815869460685, 5753.597248192628, 6055.878882422371, 6098.26820781509, 6121.173641558422, 6131.325554189036, 6217.098520714471, 6595.373439523286, 6607.504437167232, 6618.404343609098, 6654.101696271038, 6663.966680166568, 6710.0, 6743.123393958754, 6757.966210168966, 6760.459163266927, 6765.797026089176, 6193.380661933816, 6243.968780156116, 6277.52918531112, 6295.748170073191, 6299.842503937347, 6861.073755043105, 6872.62200578973, 6878.931210687829, 6953.79138625842, 6957.965210174018, 6522.412982831568, 6541.411272985454, 6555.983822507519, 6619.768308109193, 6627.10534077903, 6541.92058310383, 6602.60384376939, 6649.634270115093, 6651.966740166268, 6654.900176497356, 6550.410463058348, 6567.638779867153, 6590.934090659128, 6592.5055620828625, 6602.042703808017, 6541.018847172867, 6608.041833934052, 6621.1392518972225, 6624.403803657598, 6655.73377064912, 5465.617406781566, 5482.0406428874785, 5497.532709719719, 5498.560115190775, 5508.55931525477, 4605.516420775837, 4636.258198688193, 4660.86017419478, 4670.462896766848, 4677.508861569554, 5790.449907258888, 5800.564957628195, 5850.707464626837, 5853.239078919713, 5882.0, 6569.57297775643, 6731.360520750619, 6753.054572359873, 6765.323467653196, 6787.864242715118, 5789.913151302734, 5799.797007104816, 5855.795047173328, 5871.207387002785, 5880.852978675567, 5836.358000619928, 5886.58793884424, 5900.64596124234, 5954.672493012926, 5967.522598192134, 6512.218533775977, 6546.8363290918105, 6565.671716414256, 6570.244421891448, 6572.07990881277, 6702.329767023453, 6716.865662686817, 6742.359475849885, 6760.932390676227, 6802.319768023356, 6448.387403196689, 6465.191851018622, 6548.934510655023, 6557.180352455943, 6590.7693230736695, 6488.805335839932, 6588.472922166311, 6596.769113081019, 6658.533902626769, 6681.933180668131, 6656.167979002625, 6665.833354166185, 6668.06647069401, 6686.598804071771, 6766.05275261454, 6492.935070649233, 6617.470602351897, 6620.933790662032, 6628.038934354588, 6632.535722499379, 6534.052562378523, 6627.966860165669, 6642.070110184674, 6645.667716614246, 6650.035744817072, 6469.676516174267, 6470.06184103293, 6547.901781473377, 6570.047343135314, 6575.342465753386, 6492.253390860112, 6544.083828264142, 6636.336366363518, 6652.434543063894, 6662.367075127855, 6404.391582799627, 6414.711337989708, 6427.100205971261, 6427.646479443675, 6473.902891456538], "value": 6120.460401964352, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.9666413343466, 866.2030931542981, 875.081164776984, 892.5581836990691, 1188.316717887215, 31261.062168134937, 31721.206969825736, 31847.203819904513, 42284.57715422852, 43420.34869476953, 44156.116877662425, 44441.77779111108, 44518.777406112924, 44599.77700111503, 44622.77688611561, 7653.119891212512, 7804.648790804427, 7804.80487987802, 7807.882881756778, 7813.296803287703, 7105.8223544411285, 7334.376577990877, 7658.3873290136935, 7661.348785353224, 7707.730229441971, 7602.657880395395, 7672.961635191817, 7684.423668224906, 7686.423518236126, 7687.192844751305, 7635.503692259986, 7662.0, 7664.923350766505, 7666.7316643917475, 7681.807954801119, 7561.621918904033, 7606.3914886808925, 7606.543607383574, 7611.847763044708, 7612.923870761277, 38223.426648600296, 38441.23117537662, 38524.807375963224, 38556.22887542262, 38567.0, 3565.6969157621375, 3601.729870259715, 3605.296967091418, 3610.4584312353095, 3614.34941710492, 30497.847510762527, 30519.23701907448, 30528.08415747509, 30550.847245763627, 30573.847130764203, 4508.413906192174, 4559.270516717309, 4582.679212455129, 4606.792694328763, 4673.158831410345, 192184.0, 194499.0, 194522.0, 195450.0, 195544.99999999857, 48201.276980845316, 48433.273500897514, 48449.51550484521, 48496.0, 48630.513694862595, 50775.98448031019, 55303.44696553063, 55818.44181558213, 55941.7202913991, 55979.72010139923, 16642.833571664127, 16756.245968931427, 16763.748543771853, 16764.664706705797, 16771.748423773653, 11999.700007499883, 13373.598792036255, 13607.0, 13612.523561675294, 13612.65968350799, 13062.804057939138, 14607.342669579895, 14931.925340373446, 14934.626634334229, 14966.102033878002, 5656.830295091154, 5742.339630942495, 5775.0, 5899.410058994066, 5974.910376344358, 991.4101109839634, 1001.7846163074973, 1024.262530977695, 1026.6868605075374, 1033.9172866170688, 23231.010665413698, 23497.882510587337, 23704.28887133354, 23751.52496950086, 23977.130427407872, 1088.0642647323295, 1089.553283153903, 1107.9058280046124, 1117.3519358771894, 1130.773845230957, 12360.381980900918, 12502.624921252376, 12561.811572826415, 12631.431585578672, 12690.619281421572, 252309.0, 254390.0, 254889.0, 256853.0, 257991.0, 52966.0, 53237.467625324025, 53330.99999999922, 53448.73275633597, 53538.73230633822, 1436.8491308412674, 1453.6220582648587, 1477.697072100217, 1480.6668499587722, 1508.6077619818707, 22769.658455122855, 22808.0, 22854.771452285928, 22872.771272287064, 22945.655815162452, 37890.8105459471, 38094.238115236985, 38100.42849357317, 38113.80943095267, 38204.6179538201, 210822.0, 210903.0, 211089.0, 211419.0, 211579.0, 32587.674123259414, 32654.0, 33008.0, 33066.0, 33079.0, 42146.57853421426, 42161.156776864904, 42229.78885105678, 42277.1544569113, 42421.884007840046, 34980.0, 35089.1227719309, 35579.11052223715, 35763.284734304645, 35944.820275898455, 34554.0, 34701.30597388089, 34884.0, 34935.0, 35170.29659406746, 38361.23277534489, 38369.2326153481, 38438.42342364923, 38768.61231387763, 38779.22441551209, 33787.4931876027, 33963.66036339605, 34032.48951265783, 34239.48640770341, 34666.65333346634, 23464.530709385373, 24697.0, 24987.250382488553, 25054.498910022063, 25309.74690253074], "value": 17442.746726247442, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.899938011158, 560.3807792389412, 561.8539179813247, 569.2031156381064, 584.7310237290847, 22134.114635414586, 22786.77213227867, 22995.885020574875, 22997.425064373398, 23045.193418230367, 26136.869315653395, 27174.184774456797, 27197.728022719817, 27326.180214593594, 27338.45323093537, 6580.243272023718, 6737.157855268091, 6745.763898263562, 6747.662616869137, 6750.966245168767, 6179.7837075702355, 6490.545661803676, 6583.539152259344, 6746.426553742937, 6785.7964261072, 6783.864322713543, 6788.355106264897, 6793.5584187027935, 6795.490338224628, 6798.762043328485, 6778.254392016875, 6781.423578995767, 6782.559133656346, 6784.253732089466, 6784.592924424501, 6662.600243985328, 6686.1642294713165, 6695.430888374494, 6696.1629796275465, 6697.430718388943, 31265.37469250625, 32877.50683739746, 33290.667093329, 33492.49761253583, 33599.83200083984, 1908.9713654295058, 1953.3358658056186, 1954.15971132413, 1956.7554055743033, 1957.5204075001573, 20614.969251537364, 20954.16183352664, 20954.580908381748, 21009.264675736275, 21042.263520776698, 2411.360989337827, 2469.592517234654, 2491.526609944123, 2513.5601269777717, 2541.504406640706, 139547.0, 145497.0, 148212.0, 148630.0, 148988.0, 19665.8033419664, 20812.58374832525, 21428.0, 21771.782282177293, 22146.889265553567, 23712.40718982005, 24706.382340441272, 24718.876405617855, 44954.77522612366, 45142.77428612836, 10488.4231367274, 10492.895071049345, 10536.0, 10673.89326106729, 10706.357618542912, 9746.027461624273, 9914.40513569188, 9932.950335248277, 9986.700398988041, 10027.398356098658, 9085.0, 9373.109554592304, 9427.90572094284, 9537.0, 9726.951365243129, 2700.8919643214444, 2771.80597358183, 2782.3600571868583, 2823.378856651533, 2839.162447078117, 913.9725808225763, 964.1130160252584, 978.5596481583316, 981.5975450065439, 991.3358050106445, 19471.902640486707, 19817.60364792696, 19917.0, 20264.18943242254, 20434.284800031928, 1015.1624909449733, 1030.953607087683, 1039.308859608352, 1043.1498328861953, 1046.2467023742893, 10639.361638301727, 10740.677779666623, 10893.291936024134, 10952.397618131079, 11278.436078196057, 553832.0, 573922.0, 574957.0, 575329.0, 581052.0, 119946.0, 127842.0, 128063.359683201, 128759.35620322026, 129848.35075824561, 1191.1747447482812, 1211.7939950208486, 1227.2820400065882, 1238.646985609097, 1239.324568110382, 17220.311187552357, 17478.213480393668, 17516.474505764847, 17550.648987019933, 18286.451406457294, 55702.72148639231, 56806.71596642156, 59808.401915982024, 60171.39828601658, 62629.373706262355, 70113.29886701272, 70332.0, 70488.29511705022, 70789.6460517694, 71321.0, 14778.261086945395, 15232.314545845686, 15290.77063844021, 15371.538853834403, 15413.768793467883, 24256.69561391665, 24271.514569708153, 24380.6342904853, 24529.877350613133, 24590.508189835746, 18630.906845466227, 19115.23539058422, 19153.13810878486, 19266.614667706286, 19274.518137046685, 16770.413035543697, 17264.223109960334, 17309.74035389445, 17621.295148193927, 17669.116544172997, 18879.716804248223, 19857.900710496357, 19939.501512462306, 20178.899105504377, 20209.191632334543, 14795.852041479879, 14977.925110374379, 15128.016678915836, 15133.394664213749, 15139.243037847844, 17559.209835557176, 17675.204615792063, 17682.0, 17815.73276400829, 17905.37331193402], "value": 12595.094193508983, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.3382791690199, 1338.7389459055476, 1347.6630842289428, 1351.2162945491616, 1370.9862901370984, 13989.790153147711, 14483.0, 14603.780943285847, 14624.707505849876, 14734.336954837032, 14495.927520362384, 14791.112533247986, 14807.25963701816, 14811.55565333039, 14824.332905019273, 2589.507993481242, 2673.5454972654647, 2734.740199681037, 2737.069396405222, 2742.6297449844315, 2701.8649067546644, 2745.135282386042, 2747.3269049083, 2750.188694335176, 2752.6421565196497, 2680.5175068487665, 2708.377073273148, 2715.3075965628736, 2723.0333231702757, 2740.1916434651725, 2657.1364306600335, 2658.8803503842278, 2678.3036410533205, 2688.8386696798257, 2694.3802925327286, 2649.483350746605, 2654.15067178501, 2668.7598116169443, 2670.626112344273, 2670.8531030793297, 13706.725865482735, 14017.31792184934, 14031.579052628336, 14036.0, 14055.226962517057, 7626.694932202705, 7726.420518461082, 8004.279614834692, 8004.759857204293, 8019.839603207962, 4844.539768722001, 5034.4713805050305, 5063.620228482879, 5119.769610367505, 5124.666896651705, 1862.37610400516, 1890.5368184794677, 1929.7973712760238, 1960.9313674021485, 1965.9901700491405, 23291.53416931669, 23865.88067059671, 23920.282391528282, 23946.880265598735, 23956.640650390258, 6838.111045564145, 6879.6216208108035, 6955.1653801544135, 7037.1555413350725, 7094.858102837914, 18544.629107417775, 18604.0, 18630.0, 18632.44102676922, 18638.0, 7846.9215307847335, 8004.719834805754, 8013.158618345106, 8018.71934482302, 8026.036875574851, 6929.44564434844, 7128.28717128283, 7131.465140114408, 7135.179454362815, 7144.3927266182955, 5016.874578135503, 5166.715830629351, 5204.947950520446, 5263.473652634706, 5270.235815806686, 1396.7416028034845, 1430.1490613085198, 1537.8769698424098, 1550.968980620404, 1560.9453669121526, 888.4358432395476, 906.207068814787, 912.4890061565544, 914.264017465933, 918.0498184379136, 7788.961055194801, 8067.596620168968, 8196.713115040944, 8206.261436470746, 8255.752327430188, 991.2862738828032, 999.6251405722854, 1004.7086344960026, 1005.5374527717332, 1016.1718199667248, 4675.883102922386, 5471.917921231185, 5520.420355862577, 5523.613347065667, 5682.914756278659, 19834.900825496068, 19840.50398740014, 20342.898285508476, 20513.58972820565, 20572.79427205739, 20080.297189598296, 20278.087486063163, 20284.985750712407, 20486.0, 20501.48746281325, 10054.0, 10247.7438064049, 10447.94776026115, 10478.895211047944, 10501.684949451528, 8247.835043298981, 8622.568871556272, 8789.252913502169, 8864.468131912106, 8923.598438070172, 16826.242819073417, 17007.319707211573, 17170.570735731708, 17178.828211718224, 17472.30110795554, 17347.219375127897, 17428.47714568514, 17761.822381776015, 17853.107344632976, 18067.63864722672, 11507.252028618113, 11667.941660291644, 11795.115366347387, 11844.46699898524, 11876.0, 13168.802467962796, 13317.267550284827, 13347.66630834198, 13359.666008349868, 13374.398152082986, 10524.526396312338, 10685.252032357972, 10744.623938162127, 10756.731081722706, 10833.729156770829, 10249.231307652106, 10294.3823370598, 10359.32664376813, 10555.366677999345, 10595.099416549372, 9313.720588382359, 9701.320907536687, 9722.027797220222, 9724.367916085715, 9785.657501987396, 7060.0, 7114.039604653305, 7120.359167674727, 7129.39400150993, 7149.571025738473, 7356.117265928123, 7370.96314518424, 7377.741779037708, 7390.889136662847, 7432.739854105081], "value": 6542.42496681986, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.5217648800711, 507.46016188974204, 521.1557277210919, 521.7782442461954, 530.8487081181864, 6223.875522489548, 6253.7498500060055, 6269.0, 6316.368363163687, 6343.555951083426, 6047.909281360772, 6134.815955521331, 6144.293406258282, 6170.47550958168, 6209.472194863442, 4905.82829600964, 4935.407751069876, 4950.381202349707, 5019.623528235379, 5023.271625614284, 4857.951420485785, 4943.480934501879, 4992.42889911694, 5020.171671674169, 5022.547970682638, 4857.417109946794, 4897.436794768611, 4912.115819152551, 4917.803287868499, 4954.628402869781, 4946.72792996385, 4974.925376119361, 4983.501649835024, 5005.621205686166, 5011.774470148852, 4453.131639330332, 4480.507144214133, 4492.989077457579, 4520.593146616788, 4523.014810225269, 6040.426159514883, 6067.787627433063, 6104.725287362079, 6124.142620033199, 6144.556029333103, 5777.335606405233, 5796.3913789052385, 5809.912851307234, 5822.7088645567555, 5831.125331200312, 6514.837129071764, 6526.477881769447, 6581.30896255891, 6588.275289718127, 6615.239247486553, 4901.2648102784515, 4908.190148625473, 4915.778789954425, 4928.67963582366, 4965.428975667808, 6821.624810635413, 6867.630667419732, 6909.1018167637885, 6926.549774264657, 7029.82075556574, 4976.800927962913, 5015.27278544609, 5017.272495488134, 5024.84925452237, 5030.320906677625, 5089.872753181126, 5118.106300668702, 5129.435762066169, 5130.692158470503, 5160.200168973815, 5711.457411545896, 5757.933018943303, 5766.855828604234, 5774.884502310014, 5819.301683797887, 6538.69226154771, 6575.145231119924, 6606.86786264272, 6609.239937407259, 6645.102911106938, 1649.4062137630444, 1674.2214870085224, 1710.7262837945868, 1723.7761189555556, 1762.8012951193311, 1199.208522375228, 1224.5530381410722, 1224.773416917873, 1232.4084439469104, 1251.6557946564767, 5718.771249149988, 5790.826275211751, 5858.794942177088, 5883.941160588425, 5899.988008154496, 6704.731810727516, 6738.7304507819135, 6830.316968303229, 6862.862742745117, 6875.518713690094, 5840.620359676607, 5844.15259787337, 5849.5612829037145, 5850.151727999416, 5853.180554722342, 3623.1123374772824, 3624.220792529566, 3626.256617393428, 3631.727620428426, 3640.690541303966, 6605.867882642417, 6609.86780264392, 6630.171228596426, 6633.7346506140175, 6649.667516624149, 7016.2632923543315, 7042.6126563039525, 7061.611611361424, 7065.328793764585, 7066.222715501291, 6505.316941721146, 6510.511711621647, 6535.0, 6560.376764207488, 6628.602283862983, 6732.475321754342, 6766.1880574329425, 6815.591064536144, 6816.659167041727, 6870.175578930561, 6702.497312701469, 6713.765018224339, 6763.526553141233, 6769.323067693192, 6810.9318906810295, 6555.147830781968, 6638.502112341497, 6650.700718467584, 6665.833354166185, 6684.766033188815, 5523.309586301712, 5539.0, 5569.888602228014, 5638.323401191883, 5655.858603534944, 6859.211190713132, 6943.236244013256, 6944.51388402807, 6947.340002699735, 6951.478639102189, 6624.668766561749, 6651.0, 6665.800025999034, 6667.066610674412, 6690.330966903271, 6554.672266386567, 6581.144451221502, 6650.667466626553, 6672.933270667425, 6687.799366019027, 6118.296395914527, 6298.622082675054, 6374.203224596926, 6467.353264673683, 6514.990176522647, 6575.243846957661, 6632.303608121078, 6693.531452798452, 6693.765718199839, 6715.462762978852, 6317.273513545817, 6384.265809431975, 6399.360063993563, 6406.423421892052, 6473.385028422293], "value": 5109.228978194607, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.9139381758731, 907.5099446298999, 925.7407925780775, 927.5408672707011, 928.4522131942152, 18758.90620546897, 19439.125239364246, 19623.0, 19671.803281967175, 21603.45991350217, 21147.365579032616, 21770.89114554425, 21969.23107691231, 21995.23016694416, 22022.669659955114, 1043.446973104254, 1068.310939444058, 1068.3429690740177, 1068.8610480637544, 1068.9572417103345, 1021.918246540275, 1059.1262208677833, 1060.5969731502057, 1061.6284300494842, 1061.7982583309185, 1110.3726394587072, 1118.9552417903315, 1119.1774046076127, 1120.1542835159444, 1120.3501968858084, 1119.776044791041, 1121.8092924202906, 1123.3316176874746, 1124.1961997172061, 1125.4485302201945, 818.6193420059641, 819.1153554161491, 820.8522465956125, 821.2649678537675, 821.5481485183126, 19782.109805058808, 19953.0, 19967.400977970683, 20303.4924126898, 20375.286864959802, 21304.573908521743, 21583.2445864394, 21786.346409607737, 21816.672749908765, 22201.44496387587, 16163.83836161635, 16436.342546298132, 16482.42311519091, 16513.83486165135, 16581.25384357707, 3617.2946275476293, 3644.1254099016046, 3645.708343332527, 3657.6159503252306, 3663.0292972362345, 110909.44545277303, 111875.44062279718, 112821.43589282001, 113569.43215283954, 115739.42130289295, 16307.59231019234, 16466.75299870503, 16989.150542472828, 16991.06549139809, 16994.150292485327, 30156.0, 30804.383912322075, 31000.68999309978, 31027.224319392197, 31051.378972420425, 8429.40994130405, 8682.218600326001, 8700.695475658322, 8720.345974051845, 8749.081346458657, 4171.833126674899, 4221.050263690645, 4252.659787217077, 4272.060146767706, 4272.230998420314, 4506.662000349987, 4859.271109333557, 4915.58217551505, 4919.385076865392, 4921.9507804921495, 900.1916249498624, 910.4218821048681, 920.0661328751323, 924.0251534630894, 925.8194652042787, 702.3398005874461, 717.5694583250008, 718.1095441652418, 720.8125887269348, 742.8254360225343, 11426.485808138654, 11555.76888462226, 13727.010637240362, 13884.861151388357, 13957.371918263703, 705.9752908648172, 711.6370650968043, 712.6650474277081, 716.3660160757767, 722.0108451421481, 5846.532277417797, 5929.911051334234, 5969.134475501115, 6117.632942023492, 6180.845478863064, 106531.0, 107577.92422075836, 109480.71557853278, 109645.45177274062, 111100.0, 97392.0, 97715.0, 100161.49919250503, 102934.0, 103212.0, 80708.0, 82932.0, 83003.16996829954, 86949.0, 87590.12409875946, 12183.878161218274, 12722.109452338247, 12812.487500499876, 12936.610608020774, 13088.345582720636, 34858.65141348656, 37891.62108378991, 39197.0, 40368.798156009034, 40583.1883362337, 67319.0, 70058.0, 71709.0, 71937.28062719306, 72071.0, 19276.783169935636, 19905.0, 20067.397978060682, 20407.591848162658, 20554.38336849897, 19996.0, 20060.59878802445, 20141.899290503454, 20208.292709755675, 20306.492337691678, 19939.0, 19940.60118797645, 19945.800541994395, 19977.300794472125, 20332.08505617221, 15733.527994160193, 15736.68526629438, 15885.205739712737, 15951.122688251793, 16051.678966420839, 19079.14143863502, 19136.0, 19173.90413047926, 19582.804171958098, 19706.31027914016, 13448.596542103753, 13627.976101419257, 13733.519326823513, 14005.579832605039, 14100.717985640435, 13360.732785344433, 13737.450501979809, 13799.0, 13920.72158556803, 13960.2321872298], "value": 9281.662916493933, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1510.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 115.0, 101.0, 109.0, 110.0, 111.0, 108.0, 99.0, 107.0, 109.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 119.0, 141.0, 166.0, 117.0, 141.0, 147.0, 117.0, 174.0, 121.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 163.0, 163.0, 166.0, 165.0, 169.0, 169.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 174.0, 80.0, 76.0, 75.0, 74.0, 161.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 130.0, 78.0, 79.0, 79.0, 134.0, 78.0, 78.0, 124.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 118.0, 118.0, 117.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 151.0, 150.0, 150.0, 150.0, 151.0, 150.0, 149.0, 150.0], "value": 150.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 96.0, 94.0, 98.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 53.0, 52.0, 53.0, 54.0, 54.0, 54.0, 53.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 55.0, 54.0, 55.0, 56.0, 56.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 75.0, 74.0, 74.0, 73.0, 74.0, 75.0, 75.0, 76.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 134.0, 122.0, 127.0, 121.0, 120.0, 119.0, 121.0, 156.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 168.0, 179.0, 176.0, 171.0, 170.0, 173.0, 175.0, 168.0, 176.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 67.0, 70.0, 69.0, 68.0, 66.0, 65.0, 65.0], "value": 67.8, "unit": "score"}]}]} 08:53:05 INFO - Return code: 0 08:53:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:53:05 INFO - # TBPL SUCCESS # 08:53:05 INFO - Running post-action listener: _package_coverage_data 08:53:05 INFO - Running post-action listener: _resource_record_post_action 08:53:05 INFO - [mozharness: 2017-08-19 15:53:05.737880Z] Finished run-tests step (success) 08:53:05 INFO - Running post-run listener: _resource_record_post_run 08:53:05 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 437313536; Read time: 8; Write time: 366124 08:53:05 INFO - TinderboxPrint: CPU usage
13.1% 08:53:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:53:05 INFO - TinderboxPrint: I/O write bytes / time
437,313,536 / 366,124 08:53:05 INFO - TinderboxPrint: CPU idle
8,247.6 (86.8%) 08:53:05 INFO - TinderboxPrint: CPU user
1,199.5 (12.6%) 08:53:05 INFO - TinderboxPrint: Swap in / out
0 / 0 08:53:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107790336; Read time: 0; Write time: 103800 08:53:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:53:05 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 329523200; Read time: 0; Write time: 262324 08:53:06 INFO - Running post-run listener: _upload_blobber_files 08:53:06 INFO - Blob upload gear active. 08:53:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:53:06 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 08:53:06 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'] 08:53:06 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 08:53:06 INFO - (blobuploader) - INFO - Open directory for files ... 08:53:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:53:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:53:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:07 INFO - (blobuploader) - INFO - Done attempting. 08:53:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:53:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:53:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:09 INFO - (blobuploader) - INFO - Done attempting. 08:53:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:53:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:53:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:16 INFO - (blobuploader) - INFO - Done attempting. 08:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:53:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:17 INFO - (blobuploader) - INFO - Done attempting. 08:53:17 INFO - (blobuploader) - INFO - Iteration through files over. 08:53:17 INFO - Return code: 0 08:53:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:53:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:53:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0e86721dd625ca47731a752ba513e9d8a2dc6c839b444a74c1d3bf94f07fc796b9446004d2092e9ff304d793dede4e833aedf170ab1a744cd5d7fcf86742575", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c245ba60a2f74caa52774087de24915677f2198b90d5d0e314b3bc9c72fc51bf8fc481eff11007de508420e5facaa341be3f4a98630f85c8459140dfcfa00a71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7436abd026cec03672f57ba6d7531d9d019a19892456ce5388afd4e643c57637456f82497125df7bc2276b93505e0d035dd40dde1aa558aa51848d2e2b597b81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c13670d5bf657e96533d7b07809715f45e75503e198b5145409d52921171b53566c8b7315f214fdeea4897aa489233d387e4c1a6f262e56ba06e3f4e52dd543"} 08:53:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:53:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:53:17 INFO - Contents: 08:53:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0e86721dd625ca47731a752ba513e9d8a2dc6c839b444a74c1d3bf94f07fc796b9446004d2092e9ff304d793dede4e833aedf170ab1a744cd5d7fcf86742575", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c245ba60a2f74caa52774087de24915677f2198b90d5d0e314b3bc9c72fc51bf8fc481eff11007de508420e5facaa341be3f4a98630f85c8459140dfcfa00a71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7436abd026cec03672f57ba6d7531d9d019a19892456ce5388afd4e643c57637456f82497125df7bc2276b93505e0d035dd40dde1aa558aa51848d2e2b597b81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c13670d5bf657e96533d7b07809715f45e75503e198b5145409d52921171b53566c8b7315f214fdeea4897aa489233d387e4c1a6f262e56ba06e3f4e52dd543"} 08:53:17 INFO - Running post-run listener: copy_logs_to_upload_dir 08:53:17 INFO - Copying logs to upload dir... 08:53:17 INFO - mkdir: /builds/slave/test/build/upload/logs 08:53:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.264984 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-19 08:53:17.140533) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-19 08:53:17.144287) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0e86721dd625ca47731a752ba513e9d8a2dc6c839b444a74c1d3bf94f07fc796b9446004d2092e9ff304d793dede4e833aedf170ab1a744cd5d7fcf86742575", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c245ba60a2f74caa52774087de24915677f2198b90d5d0e314b3bc9c72fc51bf8fc481eff11007de508420e5facaa341be3f4a98630f85c8459140dfcfa00a71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7436abd026cec03672f57ba6d7531d9d019a19892456ce5388afd4e643c57637456f82497125df7bc2276b93505e0d035dd40dde1aa558aa51848d2e2b597b81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c13670d5bf657e96533d7b07809715f45e75503e198b5145409d52921171b53566c8b7315f214fdeea4897aa489233d387e4c1a6f262e56ba06e3f4e52dd543"} build_url:https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011411 build_url: 'https://queue.taskcluster.net/v1/task/BQOBZmIbRmqiqlbCbm97Hw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c0e86721dd625ca47731a752ba513e9d8a2dc6c839b444a74c1d3bf94f07fc796b9446004d2092e9ff304d793dede4e833aedf170ab1a744cd5d7fcf86742575", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c245ba60a2f74caa52774087de24915677f2198b90d5d0e314b3bc9c72fc51bf8fc481eff11007de508420e5facaa341be3f4a98630f85c8459140dfcfa00a71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7436abd026cec03672f57ba6d7531d9d019a19892456ce5388afd4e643c57637456f82497125df7bc2276b93505e0d035dd40dde1aa558aa51848d2e2b597b81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c13670d5bf657e96533d7b07809715f45e75503e198b5145409d52921171b53566c8b7315f214fdeea4897aa489233d387e4c1a6f262e56ba06e3f4e52dd543"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-19 08:53:17.176070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 08:53:17.176837) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503148616.12161-1563657577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-19 08:53:17.258804) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-19 08:53:17.259560) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-19 08:53:17.260317) ========= ========= Total master_lag: 0.20 =========