[94.845225] Initializing watchdogs [94.845337] /dev/watchdog0 [94.870261] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640 [94.876607] [001/162] (960s left) i915_module_load (load) [95.498281] Starting subtest: load [97.889912] Subtest load: SUCCESS (2.390s) [97.940658] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [97.942901] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [97.946504] [002/162] (957s left) core_auth (basic-auth) [98.060510] Starting subtest: basic-auth [98.061618] Subtest basic-auth: SUCCESS (0.001s) [98.135115] [003/162] (957s left) core_debugfs (read-all-entries) [98.192453] Starting subtest: read-all-entries [98.196474] Subtest read-all-entries: SUCCESS (0.004s) [98.245918] [004/162] (957s left) core_sysfs (read-all-entries) [98.303083] Starting subtest: read-all-entries [98.307692] Subtest read-all-entries: SUCCESS (0.005s) [98.356841] [005/162] (957s left) fbdev (eof) [98.424355] Subtest eof: SKIP (0.000s) [98.469667] [006/162] (957s left) fbdev (info) [98.535957] Subtest info: SKIP (0.000s) [98.581241] [007/162] (957s left) fbdev (nullptr) [98.650277] Subtest nullptr: SKIP (0.000s) [98.695828] [008/162] (957s left) fbdev (read) [98.763236] Subtest read: SKIP (0.000s) [98.808931] [009/162] (956s left) fbdev (write) [98.876385] Subtest write: SKIP (0.000s) [98.922650] [010/162] (956s left) gem_basic (bad-close) [98.981194] Starting subtest: bad-close [98.983099] Subtest bad-close: SUCCESS (0.000s) [99.031340] [011/162] (956s left) gem_basic (create-close) [99.090527] Starting subtest: create-close [99.092494] Subtest create-close: SUCCESS (0.000s) [99.159993] [012/162] (956s left) gem_basic (create-fd-close) [99.217603] Starting subtest: create-fd-close [99.219432] Subtest create-fd-close: SUCCESS (0.000s) [99.283883] [013/162] (956s left) gem_busy (busy@all-engines) [99.362518] Starting subtest: busy [99.363523] Starting dynamic subtest: all-engines [99.422206] Dynamic subtest all-engines: SUCCESS (0.060s) [99.423157] Subtest busy: SUCCESS (0.060s) [99.821899] [014/162] (956s left) gem_close_race (basic-process) [99.905447] Starting subtest: basic-process [99.969069] Subtest basic-process: SUCCESS (0.064s) [100.211635] [015/162] (955s left) gem_close_race (basic-threads) [100.291448] Starting subtest: basic-threads [101.501034] Subtest basic-threads: SUCCESS (1.185s) [101.688209] [016/162] (954s left) gem_ctx_create (basic) [101.771087] Starting subtest: basic [101.772336] Subtest basic: SUCCESS (0.000s) [101.965898] [017/162] (954s left) gem_ctx_create (basic-files) [102.040129] Starting subtest: basic-files [104.058440] Subtest basic-files: SUCCESS (2.018s) [104.286259] [018/162] (952s left) gem_ctx_exec (basic) [104.351199] Starting subtest: basic [104.357119] Subtest basic: SUCCESS (0.006s) [104.450174] [019/162] (951s left) gem_exec_basic (basic) [104.518553] Starting subtest: basic [104.519695] Starting dynamic subtest: rcs0-smem [104.522775] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [104.533219] Starting dynamic subtest: bcs0-smem [104.534278] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [104.543759] Starting dynamic subtest: vcs0-smem [104.544966] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [104.554647] Starting dynamic subtest: vcs1-smem [104.555841] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [104.565455] Starting dynamic subtest: vecs0-smem [104.566660] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [104.567847] Subtest basic: SUCCESS (0.012s) [104.747073] [020/162] (951s left) gem_exec_create (basic) [104.827511] Starting subtest: basic [104.828613] Starting dynamic subtest: smem [106.911139] Dynamic subtest smem: SUCCESS (2.045s) [106.913036] Subtest basic: SUCCESS (2.046s) [107.054446] [021/162] (949s left) gem_exec_fence (basic-busy) [107.277266] Starting subtest: basic-busy [107.278594] Starting dynamic subtest: rcs0 [107.318036] Dynamic subtest rcs0: SUCCESS (0.040s) [107.328719] Starting dynamic subtest: bcs0 [107.339463] Dynamic subtest bcs0: SUCCESS (0.022s) [107.349637] Starting dynamic subtest: vcs0 [107.361383] Dynamic subtest vcs0: SUCCESS (0.021s) [107.371253] Starting dynamic subtest: vcs1 [107.382352] Dynamic subtest vcs1: SUCCESS (0.021s) [107.393762] Starting dynamic subtest: vecs0 [107.409558] Dynamic subtest vecs0: SUCCESS (0.027s) [107.410805] Subtest basic-busy: SUCCESS (0.133s) [108.110845] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [108.113815] [022/162] (948s left) gem_exec_fence (basic-wait) [108.323504] Starting subtest: basic-wait [108.324920] Starting dynamic subtest: rcs0 [108.356692] Dynamic subtest rcs0: SUCCESS (0.033s) [108.374736] Starting dynamic subtest: bcs0 [108.384548] Dynamic subtest bcs0: SUCCESS (0.027s) [108.399168] Starting dynamic subtest: vcs0 [108.412468] Dynamic subtest vcs0: SUCCESS (0.027s) [108.425520] Starting dynamic subtest: vcs1 [108.437415] Dynamic subtest vcs1: SUCCESS (0.024s) [108.451386] Starting dynamic subtest: vecs0 [108.457349] Dynamic subtest vecs0: SUCCESS (0.020s) [108.458704] Subtest basic-wait: SUCCESS (0.135s) [109.092648] [023/162] (947s left) gem_exec_fence (basic-await) [109.336235] Starting subtest: basic-await [109.337884] Starting dynamic subtest: rcs0 [109.433726] Dynamic subtest rcs0: SUCCESS (0.110s) [109.453417] Starting dynamic subtest: bcs0 [109.549544] Dynamic subtest bcs0: SUCCESS (0.115s) [109.565082] Starting dynamic subtest: vcs0 [109.661853] Dynamic subtest vcs0: SUCCESS (0.111s) [109.678319] Starting dynamic subtest: vcs1 [109.773924] Dynamic subtest vcs1: SUCCESS (0.112s) [109.787023] Starting dynamic subtest: vecs0 [109.897477] Dynamic subtest vecs0: SUCCESS (0.119s) [109.899023] Subtest basic-await: SUCCESS (0.571s) [110.601671] [024/162] (946s left) gem_exec_fence (nb-await) [110.823371] Starting subtest: nb-await [110.825199] Starting dynamic subtest: rcs0 [110.897055] Dynamic subtest rcs0: SUCCESS (0.077s) [110.915051] Starting dynamic subtest: bcs0 [110.974538] Dynamic subtest bcs0: SUCCESS (0.076s) [111.007223] Starting dynamic subtest: vcs0 [111.059749] Dynamic subtest vcs0: SUCCESS (0.085s) [111.090595] Starting dynamic subtest: vcs1 [111.143836] Dynamic subtest vcs1: SUCCESS (0.083s) [111.175230] Starting dynamic subtest: vecs0 [111.229311] Dynamic subtest vecs0: SUCCESS (0.082s) [111.231308] Subtest nb-await: SUCCESS (0.409s) [111.910283] [025/162] (944s left) gem_exec_gttfill (basic) [111.995531] Starting subtest: basic [116.737391] Subtest basic: SUCCESS (4.743s) [116.988433] [026/162] (939s left) gem_exec_parallel (engines) [117.150672] Starting subtest: engines [117.152227] Starting dynamic subtest: basic [119.562274] Dynamic subtest basic: SUCCESS (2.361s) [119.573776] Starting dynamic subtest: contexts [122.412016] Dynamic subtest contexts: SUCCESS (2.844s) [122.424659] Starting dynamic subtest: fds [127.117472] Dynamic subtest fds: SUCCESS (4.760s) [127.129434] Starting dynamic subtest: userptr [129.486417] Dynamic subtest userptr: SUCCESS (2.321s) [129.488368] Subtest engines: SUCCESS (12.289s) [129.645610] [027/162] (927s left) gem_exec_store (basic) [129.732180] Starting subtest: basic [129.797910] Subtest basic: SUCCESS (0.066s) [129.994414] [028/162] (927s left) gem_flink_basic (bad-flink) [130.051375] Starting subtest: bad-flink [130.052475] Subtest bad-flink: SUCCESS (0.000s) [130.105949] [029/162] (927s left) gem_flink_basic (bad-open) [130.165434] Starting subtest: bad-open [130.166574] Subtest bad-open: SUCCESS (0.000s) [130.222899] [030/162] (926s left) gem_flink_basic (basic) [130.508513] Starting subtest: basic [130.510574] Subtest basic: SUCCESS (0.000s) [130.593991] [031/162] (926s left) gem_flink_basic (double-flink) [130.653512] Starting subtest: double-flink [130.654430] Subtest double-flink: SUCCESS (0.000s) [130.727795] [032/162] (926s left) gem_flink_basic (flink-lifetime) [130.784191] Starting subtest: flink-lifetime [130.786296] Subtest flink-lifetime: SUCCESS (0.002s) [130.861753] [033/162] (926s left) gem_huc_copy (huc-copy) [130.928628] Starting subtest: huc-copy [130.930591] Subtest huc-copy: SKIP (0.000s) [131.022680] [034/162] (926s left) gem_linear_blits (basic) [131.189424] Starting subtest: basic [131.197963] Subtest basic: SUCCESS (0.010s) [131.367259] [035/162] (926s left) gem_mmap (basic) [131.525724] Starting subtest: basic [131.532093] Subtest basic: SUCCESS (0.001s) [131.611535] [036/162] (925s left) gem_mmap_gtt (basic) [131.668576] Starting subtest: basic [131.669559] Subtest basic: SUCCESS (0.001s) [131.725581] [037/162] (925s left) gem_render_linear_blits (basic) [131.792342] Starting subtest: basic [131.825292] Subtest basic: SUCCESS (0.033s) [131.892208] [038/162] (925s left) gem_render_tiled_blits (basic) [131.964180] Starting subtest: basic [132.007514] Subtest basic: SUCCESS (0.044s) [132.074228] [039/162] (925s left) gem_ringfill (basic-all) [132.370071] Starting subtest: basic-all [133.598509] Subtest basic-all: SUCCESS (1.173s) [133.653605] [040/162] (924s left) gem_softpin (allocator-basic) [133.728441] Starting subtest: allocator-basic [133.939627] Subtest allocator-basic: SUCCESS (0.156s) [133.994489] [041/162] (923s left) gem_softpin (allocator-basic-reserve) [134.067430] Starting subtest: allocator-basic-reserve [134.270759] Subtest allocator-basic-reserve: SUCCESS (0.147s) [134.322730] [042/162] (923s left) gem_softpin (safe-alignment) [134.404630] Starting subtest: safe-alignment [134.424091] Subtest safe-alignment: SUCCESS (0.019s) [134.511699] [043/162] (923s left) gem_sync (basic-all) [134.593641] Starting subtest: basic-all [137.050764] Subtest basic-all: SUCCESS (2.420s) [137.225287] [044/162] (920s left) gem_sync (basic-each) [137.305507] Starting subtest: basic-each [139.535603] Subtest basic-each: SUCCESS (2.230s) [139.786408] [045/162] (918s left) gem_tiled_blits (basic) [139.923085] Starting subtest: basic [139.943834] Subtest basic: SUCCESS (0.021s) [140.063956] [046/162] (918s left) gem_tiled_fence_blits (basic) [140.616280] Starting subtest: basic [140.626522] Subtest basic: SUCCESS (0.011s) [140.721086] [047/162] (917s left) gem_tiled_pread_basic (basic) [140.837040] Starting subtest: basic [141.037811] Subtest basic: SUCCESS (0.144s) [141.102599] [048/162] (917s left) gem_wait (busy@all-engines) [141.188821] Starting subtest: busy [141.190100] Starting dynamic subtest: all-engines [141.763080] Dynamic subtest all-engines: SUCCESS (0.527s) [141.765059] Subtest busy: SUCCESS (0.527s) [141.898579] [049/162] (916s left) gem_wait (wait@all-engines) [141.985136] Starting subtest: wait [141.986341] Starting dynamic subtest: all-engines [143.075059] Dynamic subtest all-engines: SUCCESS (1.041s) [143.077631] Subtest wait: SUCCESS (1.042s) [143.243629] [050/162] (915s left) i915_getparams_basic (basic-eu-total) [143.310253] Starting subtest: basic-eu-total [143.312410] Subtest basic-eu-total: SUCCESS (0.000s) [143.363585] [051/162] (915s left) i915_getparams_basic (basic-subslice-total) [143.420122] Starting subtest: basic-subslice-total [143.422356] Subtest basic-subslice-total: SUCCESS (0.000s) [143.477669] [052/162] (915s left) i915_hangman (error-state-basic) [143.558545] Starting subtest: error-state-basic [143.565556] Subtest error-state-basic: SUCCESS (0.007s) [143.772849] [053/162] (915s left) i915_pciid [144.006628] [054/162] (914s left) intel_hwmon (hwmon-read) [144.063996] Subtest hwmon-read: SKIP (0.000s) [144.119768] [055/162] (914s left) intel_hwmon (hwmon-write) [144.178770] Subtest hwmon-write: SKIP (0.000s) [144.231444] [056/162] (914s left) kms_addfb_basic (addfb25-4-tiled) [144.518260] Starting subtest: addfb25-4-tiled [144.519446] Subtest addfb25-4-tiled: SUCCESS (0.001s) [144.606781] [057/162] (914s left) kms_addfb_basic (addfb25-bad-modifier) [144.878574] Starting subtest: addfb25-bad-modifier [144.879646] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [144.970934] [058/162] (914s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [145.260082] Starting subtest: addfb25-framebuffer-vs-set-tiling [145.261908] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [145.336201] [059/162] (913s left) kms_addfb_basic (addfb25-modifier-no-flag) [145.618306] Starting subtest: addfb25-modifier-no-flag [145.619767] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [145.714760] [060/162] (913s left) kms_addfb_basic (addfb25-x-tiled-legacy) [145.991167] Starting subtest: addfb25-x-tiled-legacy [145.992277] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [146.077073] [061/162] (913s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [146.355444] Starting subtest: addfb25-x-tiled-mismatch-legacy [146.357367] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [146.449751] [062/162] (912s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [146.719677] Starting subtest: addfb25-yf-tiled-legacy [146.720943] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [146.807289] [063/162] (912s left) kms_addfb_basic (addfb25-y-tiled-legacy) [147.083793] Starting subtest: addfb25-y-tiled-legacy [147.085280] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [147.166810] [064/162] (912s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [147.453336] Starting subtest: addfb25-y-tiled-small-legacy [147.455116] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [147.541457] [065/162] (912s left) kms_addfb_basic (bad-pitch-0) [147.600088] Starting subtest: bad-pitch-0 [147.601197] Subtest bad-pitch-0: SUCCESS (0.000s) [147.908979] [066/162] (911s left) kms_addfb_basic (bad-pitch-1024) [147.967143] Starting subtest: bad-pitch-1024 [147.968116] Subtest bad-pitch-1024: SUCCESS (0.000s) [148.273052] [067/162] (911s left) kms_addfb_basic (bad-pitch-128) [148.332974] Starting subtest: bad-pitch-128 [148.333936] Subtest bad-pitch-128: SUCCESS (0.000s) [148.631881] [068/162] (911s left) kms_addfb_basic (bad-pitch-256) [148.691303] Starting subtest: bad-pitch-256 [148.692241] Subtest bad-pitch-256: SUCCESS (0.000s) [148.991771] [069/162] (910s left) kms_addfb_basic (bad-pitch-32) [149.050059] Starting subtest: bad-pitch-32 [149.051027] Subtest bad-pitch-32: SUCCESS (0.000s) [149.351338] [070/162] (910s left) kms_addfb_basic (bad-pitch-63) [149.410888] Starting subtest: bad-pitch-63 [149.411834] Subtest bad-pitch-63: SUCCESS (0.000s) [149.718970] [071/162] (910s left) kms_addfb_basic (bad-pitch-65536) [149.778041] Starting subtest: bad-pitch-65536 [149.779143] Subtest bad-pitch-65536: SUCCESS (0.000s) [150.077776] [072/162] (909s left) kms_addfb_basic (bad-pitch-999) [150.136128] Starting subtest: bad-pitch-999 [150.136999] Subtest bad-pitch-999: SUCCESS (0.000s) [150.432734] [073/162] (909s left) kms_addfb_basic (basic) [150.490148] Starting subtest: basic [150.491135] Subtest basic: SUCCESS (0.000s) [150.810405] [074/162] (909s left) kms_addfb_basic (basic-x-tiled-legacy) [150.871443] Starting subtest: basic-x-tiled-legacy [150.872355] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [151.177099] [075/162] (909s left) kms_addfb_basic (basic-y-tiled-legacy) [151.236655] Starting subtest: basic-y-tiled-legacy [151.237686] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [151.536587] [076/162] (908s left) kms_addfb_basic (bo-too-small) [151.810619] Starting subtest: bo-too-small [151.811790] Subtest bo-too-small: SUCCESS (0.001s) [151.885246] [077/162] (908s left) kms_addfb_basic (bo-too-small-due-to-tiling) [152.163099] Starting subtest: bo-too-small-due-to-tiling [152.164164] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [152.253753] [078/162] (908s left) kms_addfb_basic (clobberred-modifier) [152.312354] Starting subtest: clobberred-modifier [152.313352] Subtest clobberred-modifier: SUCCESS (0.000s) [152.606468] [079/162] (907s left) kms_addfb_basic (framebuffer-vs-set-tiling) [152.665175] Starting subtest: framebuffer-vs-set-tiling [152.666098] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [152.967104] [080/162] (907s left) kms_addfb_basic (invalid-get-prop) [153.024484] Starting subtest: invalid-get-prop [153.025452] Subtest invalid-get-prop: SUCCESS (0.000s) [153.336066] [081/162] (907s left) kms_addfb_basic (invalid-get-prop-any) [153.393479] Starting subtest: invalid-get-prop-any [153.394443] Subtest invalid-get-prop-any: SUCCESS (0.000s) [153.688704] [082/162] (907s left) kms_addfb_basic (invalid-set-prop) [153.749168] Starting subtest: invalid-set-prop [153.750088] Subtest invalid-set-prop: SUCCESS (0.000s) [154.053925] [083/162] (906s left) kms_addfb_basic (invalid-set-prop-any) [154.111431] Starting subtest: invalid-set-prop-any [154.112390] Subtest invalid-set-prop-any: SUCCESS (0.000s) [154.404650] [084/162] (906s left) kms_addfb_basic (no-handle) [154.464712] Starting subtest: no-handle [154.465659] Subtest no-handle: SUCCESS (0.000s) [154.759639] [085/162] (906s left) kms_addfb_basic (size-max) [155.146681] Starting subtest: size-max [155.148197] Subtest size-max: SUCCESS (0.000s) [155.232986] [086/162] (905s left) kms_addfb_basic (small-bo) [155.510534] Starting subtest: small-bo [155.511496] Subtest small-bo: SUCCESS (0.000s) [155.591648] [087/162] (905s left) kms_addfb_basic (tile-pitch-mismatch) [155.650200] Starting subtest: tile-pitch-mismatch [155.651122] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [155.963394] [088/162] (905s left) kms_addfb_basic (too-high) [156.236827] Starting subtest: too-high [156.239960] Subtest too-high: SUCCESS (0.003s) [156.320274] [089/162] (904s left) kms_addfb_basic (too-wide) [156.590950] Starting subtest: too-wide [156.592434] Subtest too-wide: SUCCESS (0.000s) [156.689932] [090/162] (904s left) kms_addfb_basic (unused-handle) [156.746612] Starting subtest: unused-handle [156.747597] Subtest unused-handle: SUCCESS (0.000s) [157.075774] [091/162] (904s left) kms_addfb_basic (unused-modifier) [157.135147] Starting subtest: unused-modifier [157.136609] Subtest unused-modifier: SUCCESS (0.000s) [157.429283] [092/162] (903s left) kms_addfb_basic (unused-offsets) [157.487309] Starting subtest: unused-offsets [157.488287] Subtest unused-offsets: SUCCESS (0.000s) [157.780096] [093/162] (903s left) kms_addfb_basic (unused-pitches) [157.837138] Starting subtest: unused-pitches [157.838073] Subtest unused-pitches: SUCCESS (0.000s) [158.143341] [094/162] (903s left) kms_busy (basic) [158.434968] Subtest basic: SKIP (0.000s) [158.498755] [095/162] (903s left) kms_prop_blob (basic) [158.557368] Starting subtest: basic [158.558626] Subtest basic: SUCCESS (0.000s) [158.611313] [096/162] (903s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [158.887047] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [158.947897] [097/162] (902s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [159.220503] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [159.284155] [098/162] (902s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [159.572148] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [159.634405] [099/162] (902s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [159.917120] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [159.978543] [100/162] (901s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [160.251842] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [160.308254] [101/162] (901s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [160.580940] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [160.644021] [102/162] (901s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [160.927211] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [160.984462] [103/162] (901s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [161.262127] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [161.324943] [104/162] (900s left) kms_dsc (dsc-basic) [161.601949] Subtest dsc-basic: SKIP (0.000s) [161.670908] [105/162] (900s left) kms_flip (basic-flip-vs-dpms) [161.952177] Starting subtest: basic-flip-vs-dpms [161.954312] Subtest basic-flip-vs-dpms: SKIP (0.003s) [162.029705] [106/162] (900s left) kms_flip (basic-flip-vs-modeset) [162.299507] Starting subtest: basic-flip-vs-modeset [162.305030] Subtest basic-flip-vs-modeset: SKIP (0.003s) [162.381698] [107/162] (899s left) kms_flip (basic-flip-vs-wf_vblank) [162.652189] Starting subtest: basic-flip-vs-wf_vblank [162.655599] Subtest basic-flip-vs-wf_vblank: SKIP (0.003s) [162.734748] [108/162] (899s left) kms_flip (basic-plain-flip) [163.020703] Starting subtest: basic-plain-flip [163.024903] Subtest basic-plain-flip: SKIP (0.002s) [163.101732] [109/162] (899s left) kms_force_connector_basic (force-connector-state) [163.495317] Starting subtest: force-connector-state [164.279416] Subtest force-connector-state: SUCCESS (0.783s) [164.881164] [110/162] (897s left) kms_force_connector_basic (force-edid) [165.274347] Starting subtest: force-edid [165.915350] Subtest force-edid: SUCCESS (0.641s) [166.420362] [111/162] (896s left) kms_force_connector_basic (force-load-detect) [166.803274] Starting subtest: force-load-detect [166.805330] Subtest force-load-detect: SKIP (0.000s) [167.190242] [112/162] (895s left) kms_force_connector_basic (prune-stale-modes) [167.579283] Starting subtest: prune-stale-modes [168.317834] Subtest prune-stale-modes: SUCCESS (0.739s) [168.811130] [113/162] (893s left) kms_frontbuffer_tracking (basic) [169.086683] Subtest basic: SKIP (0.000s) [169.165952] [114/162] (893s left) kms_hdmi_inject (inject-audio) [169.227766] Starting subtest: inject-audio [169.860772] Subtest inject-audio: SUCCESS (0.631s) [170.115583] [115/162] (892s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [170.388147] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [170.463604] [116/162] (892s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [170.730481] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [170.800593] [117/162] (892s left) kms_pipe_crc_basic (hang-read-crc) [171.078294] Subtest hang-read-crc: SKIP (0.000s) [171.147773] [118/162] (891s left) kms_pipe_crc_basic (nonblocking-crc) [171.419114] Subtest nonblocking-crc: SKIP (0.000s) [171.489147] [119/162] (891s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [171.766454] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [171.831082] [120/162] (891s left) kms_pipe_crc_basic (read-crc) [172.113312] Subtest read-crc: SKIP (0.000s) [172.182070] [121/162] (891s left) kms_pipe_crc_basic (read-crc-frame-sequence) [172.448690] Subtest read-crc-frame-sequence: SKIP (0.000s) [172.524789] [122/162] (890s left) kms_pm_backlight (basic-brightness) [172.801327] Subtest basic-brightness: SKIP (0.000s) [172.872952] [123/162] (890s left) kms_pm_rpm (basic-pci-d3-state) [174.506948] Starting subtest: basic-pci-d3-state [174.856617] Subtest basic-pci-d3-state: SUCCESS (0.351s) [175.026295] [124/162] (888s left) kms_pm_rpm (basic-rte) [175.347137] Starting subtest: basic-rte [177.260318] Subtest basic-rte: SUCCESS (1.950s) [177.712883] [125/162] (885s left) kms_psr (psr-primary-page-flip) [178.244333] Subtest psr-primary-page-flip: SKIP (0.000s) [178.321416] [126/162] (885s left) kms_psr (psr-cursor-plane-move) [178.594213] Subtest psr-cursor-plane-move: SKIP (0.000s) [178.659977] [127/162] (884s left) kms_psr (psr-sprite-plane-onoff) [178.933217] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [179.004394] [128/162] (884s left) kms_psr (psr-primary-mmap-gtt) [179.276461] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [179.350060] [129/162] (884s left) kms_setmode (basic-clone-single-crtc) [179.407775] Starting subtest: basic-clone-single-crtc [179.411245] Subtest basic-clone-single-crtc: SKIP (0.000s) [179.473493] [130/162] (884s left) i915_pm_rps (basic-api) [179.545175] Starting subtest: basic-api [179.548651] Subtest basic-api: SUCCESS (0.005s) [179.610616] [131/162] (884s left) prime_self_import (basic-llseek-bad) [179.672124] Starting subtest: basic-llseek-bad [179.674009] Subtest basic-llseek-bad: SUCCESS (0.003s) [179.746571] [132/162] (884s left) prime_self_import (basic-llseek-size) [179.804144] Starting subtest: basic-llseek-size [179.806186] Subtest basic-llseek-size: SUCCESS (0.004s) [179.885702] [133/162] (884s left) prime_self_import (basic-with_fd_dup) [179.941152] Starting subtest: basic-with_fd_dup [179.944342] Subtest basic-with_fd_dup: SUCCESS (0.004s) [180.023246] [134/162] (883s left) prime_self_import (basic-with_one_bo) [180.079276] Starting subtest: basic-with_one_bo [180.082616] Subtest basic-with_one_bo: SUCCESS (0.004s) [180.150571] [135/162] (883s left) prime_self_import (basic-with_one_bo_two_files) [180.222024] Starting subtest: basic-with_one_bo_two_files [180.223954] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [180.308476] [136/162] (883s left) prime_self_import (basic-with_two_bos) [180.362103] Starting subtest: basic-with_two_bos [180.366516] Subtest basic-with_two_bos: SUCCESS (0.004s) [180.450855] [137/162] (883s left) prime_vgem (basic-fence-flip) [180.519845] Starting subtest: basic-fence-flip [180.734292] Subtest basic-fence-flip: SKIP (0.210s) [180.813324] [138/162] (883s left) prime_vgem (basic-fence-mmap) [180.880163] Starting subtest: basic-fence-mmap [180.916138] Subtest basic-fence-mmap: SUCCESS (0.036s) [180.983613] [139/162] (883s left) prime_vgem (basic-fence-read) [181.067824] Starting subtest: basic-fence-read [181.142309] Subtest basic-fence-read: SUCCESS (0.074s) [181.209630] [140/162] (883s left) prime_vgem (basic-gtt) [181.278029] Starting subtest: basic-gtt [181.295811] Subtest basic-gtt: SUCCESS (0.018s) [181.378707] [141/162] (883s left) prime_vgem (basic-read) [181.452471] Starting subtest: basic-read [181.492033] Subtest basic-read: SUCCESS (0.039s) [181.580268] [142/162] (882s left) prime_vgem (basic-write) [181.646502] Starting subtest: basic-write [181.682824] Subtest basic-write: SUCCESS (0.036s) [181.749538] [143/162] (882s left) vgem_basic (setversion) [181.808926] Starting subtest: setversion [181.810807] Subtest setversion: SUCCESS (0.000s) [181.868268] [144/162] (882s left) vgem_basic (create) [181.927373] Starting subtest: create [181.928333] Subtest create: SUCCESS (0.000s) [181.986205] [145/162] (882s left) vgem_basic (debugfs) [182.045280] Starting subtest: debugfs [182.046235] Subtest debugfs: SUCCESS (0.001s) [182.106842] [146/162] (882s left) vgem_basic (dmabuf-export) [182.167446] Starting subtest: dmabuf-export [182.170574] Subtest dmabuf-export: SUCCESS (0.003s) [182.250463] [147/162] (882s left) vgem_basic (dmabuf-fence) [182.309530] Starting subtest: dmabuf-fence [182.310445] Subtest dmabuf-fence: SUCCESS (0.001s) [182.372242] [148/162] (882s left) vgem_basic (dmabuf-fence-before) [182.432920] Starting subtest: dmabuf-fence-before [182.434167] Subtest dmabuf-fence-before: SUCCESS (0.000s) [182.490432] [149/162] (882s left) vgem_basic (dmabuf-mmap) [182.550336] Starting subtest: dmabuf-mmap [182.561028] Subtest dmabuf-mmap: SUCCESS (0.012s) [182.621628] [150/162] (882s left) vgem_basic (mmap) [182.683058] Starting subtest: mmap [182.692557] Subtest mmap: SUCCESS (0.011s) [182.753420] [151/162] (882s left) vgem_basic (second-client) [182.814435] Starting subtest: second-client [182.817659] Subtest second-client: SUCCESS (0.003s) [182.874692] [152/162] (882s left) vgem_basic (sysfs) [182.934475] Starting subtest: sysfs [182.935449] Subtest sysfs: SUCCESS (0.001s) [182.994800] [153/162] (882s left) core_hotunplug (unbind-rebind) [183.101536] Starting subtest: unbind-rebind [187.186247] Subtest unbind-rebind: SUCCESS (4.080s) [187.241755] [154/162] (877s left) vgem_basic (unload) [187.302717] Starting subtest: unload [216.283864] Subtest unload: SUCCESS (28.924s) [216.339236] [155/162] (848s left) i915_module_load (reload) [216.403802] Starting subtest: reload [219.845826] Subtest reload: SUCCESS (3.442s) [219.932226] [156/162] (845s left) gem_lmem_swapping (basic) [220.161105] Subtest basic: SKIP (0.000s) [220.276496] [157/162] (845s left) gem_lmem_swapping (parallel-random-engines) [220.341472] Subtest parallel-random-engines: SKIP (0.000s) [220.397904] [158/162] (845s left) gem_lmem_swapping (random-engines) [220.463652] Subtest random-engines: SKIP (0.000s) [220.516985] [159/162] (845s left) gem_lmem_swapping (verify-random) [220.580539] Subtest verify-random: SKIP (0.000s) [220.670694] [160/162] (844s left) i915_pm_rpm (module-reload) [223.661281] Starting subtest: module-reload [238.050177] Subtest module-reload: SUCCESS (14.336s) [238.117482] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [238.119046] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [238.121653] [161/162] (827s left) i915_selftest (live) [238.190731] Starting subtest: live [238.192104] Starting dynamic subtest: sanitycheck [240.912649] Dynamic subtest sanitycheck: SUCCESS (2.666s) [240.923598] Starting dynamic subtest: uncore [243.527766] Dynamic subtest uncore: SUCCESS (2.614s) [243.538682] Starting dynamic subtest: workarounds [246.538645] Dynamic subtest workarounds: SUCCESS (3.010s) [246.549593] Starting dynamic subtest: gt_engines [249.658567] Dynamic subtest gt_engines: SUCCESS (3.119s) [249.672705] Starting dynamic subtest: gt_timelines [265.815734] Dynamic subtest gt_timelines: SUCCESS (16.156s) [265.826752] Starting dynamic subtest: gt_contexts [268.661815] Dynamic subtest gt_contexts: SUCCESS (2.845s) [268.672764] Starting dynamic subtest: gt_lrc [274.399933] Dynamic subtest gt_lrc: SUCCESS (5.737s) [274.410981] Starting dynamic subtest: gt_mocs [277.138408] Dynamic subtest gt_mocs: SUCCESS (2.738s) [277.149406] Starting dynamic subtest: gt_pm [288.425980] Dynamic subtest gt_pm: SUCCESS (11.285s) [288.436961] Starting dynamic subtest: gt_heartbeat [291.059985] Dynamic subtest gt_heartbeat: SUCCESS (2.633s) [291.073188] Starting dynamic subtest: gt_tlb [295.346889] Dynamic subtest gt_tlb: SUCCESS (4.285s) [295.357942] Starting dynamic subtest: requests [305.494205] Dynamic subtest requests: SUCCESS (10.145s) [305.505239] Starting dynamic subtest: migrate [311.137643] Dynamic subtest migrate: SUCCESS (5.642s) [311.148629] Starting dynamic subtest: active [313.774734] Dynamic subtest active: SUCCESS (2.635s) [313.785696] Starting dynamic subtest: objects [317.289760] Dynamic subtest objects: SUCCESS (3.513s) [317.300781] Starting dynamic subtest: mman [323.468786] Dynamic subtest mman: SUCCESS (6.177s) [323.479853] Starting dynamic subtest: dmabuf [326.141877] Dynamic subtest dmabuf: SUCCESS (2.671s) [326.156131] Starting dynamic subtest: vma [328.823483] Dynamic subtest vma: SUCCESS (2.680s) [328.834516] Starting dynamic subtest: coherency [333.756724] Dynamic subtest coherency: SUCCESS (4.931s) [333.767839] Starting dynamic subtest: gtt [343.696452] Dynamic subtest gtt: SUCCESS (9.937s) [343.707573] Starting dynamic subtest: gem [346.829852] Dynamic subtest gem: SUCCESS (3.132s) [346.844073] Starting dynamic subtest: evict [351.743095] Dynamic subtest evict: SUCCESS (4.911s) [351.754162] Starting dynamic subtest: hugepages [360.766029] Dynamic subtest hugepages: SUCCESS (9.021s) [360.777051] Starting dynamic subtest: gem_contexts [380.512175] Dynamic subtest gem_contexts: SUCCESS (19.744s) [380.526835] Starting dynamic subtest: client [383.258994] Dynamic subtest client: SUCCESS (2.745s) [383.270411] Starting dynamic subtest: gem_migrate [385.871668] Dynamic subtest gem_migrate: SUCCESS (2.611s) [385.883078] Starting dynamic subtest: reset [388.938624] Dynamic subtest reset: SUCCESS (3.065s) [388.950275] Starting dynamic subtest: memory_region [391.609100] Dynamic subtest memory_region: SUCCESS (2.668s) [391.623868] Starting dynamic subtest: hangcheck [423.013848] Dynamic subtest hangcheck: SUCCESS (31.403s) [423.028641] Starting dynamic subtest: execlists [438.799999] Dynamic subtest execlists: SUCCESS (15.784s) [438.811393] Starting dynamic subtest: ring_submission [441.424548] Dynamic subtest ring_submission: SUCCESS (2.623s) [441.439378] Starting dynamic subtest: perf [444.234069] Dynamic subtest perf: SUCCESS (2.807s) [444.245447] Starting dynamic subtest: slpc [446.870914] Dynamic subtest slpc: SUCCESS (2.635s) [446.885701] Starting dynamic subtest: guc [449.532627] Dynamic subtest guc: SUCCESS (2.660s) [449.544054] Starting dynamic subtest: guc_multi_lrc [452.166900] Dynamic subtest guc_multi_lrc: SUCCESS (2.632s) [452.181630] Starting dynamic subtest: guc_hang [454.802399] Dynamic subtest guc_hang: SUCCESS (2.633s) [454.817200] Starting dynamic subtest: late_gt_pm [457.474796] Dynamic subtest late_gt_pm: SUCCESS (2.671s) [457.477084] Subtest live: SUCCESS (219.222s) [457.562761] [162/162] (608s left) dmabuf (all-tests) [457.632121] Starting subtest: all-tests [457.634358] Subtest all-tests: SKIP (0.000s) [457.675618] Closing watchdogs results: parsing output: 0/ for test: i915_module_load results: parsing output: 1/ for test: core_auth results: parsing output: 2/ for test: core_debugfs results: parsing output: 3/ for test: core_sysfs results: parsing output: 4/ for test: fbdev results: parsing output: 5/ for test: fbdev results: parsing output: 6/ for test: fbdev results: parsing output: 7/ for test: fbdev results: parsing output: 8/ for test: fbdev results: parsing output: 9/ for test: gem_basic results: parsing output: 10/ for test: gem_basic results: parsing output: 11/ for test: gem_basic results: parsing output: 12/ for test: gem_busy results: parsing output: 13/ for test: gem_close_race results: parsing output: 14/ for test: gem_close_race results: parsing output: 15/ for test: gem_ctx_create results: parsing output: 16/ for test: gem_ctx_create results: parsing output: 17/ for test: gem_ctx_exec results: parsing output: 18/ for test: gem_exec_basic results: parsing output: 19/ for test: gem_exec_create results: parsing output: 20/ for test: gem_exec_fence results: parsing output: 21/ for test: gem_exec_fence results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: gem_exec_fence results: parsing output: 24/ for test: gem_exec_gttfill results: parsing output: 25/ for test: gem_exec_parallel results: parsing output: 26/ for test: gem_exec_store results: parsing output: 27/ for test: gem_flink_basic results: parsing output: 28/ for test: gem_flink_basic results: parsing output: 29/ for test: gem_flink_basic results: parsing output: 30/ for test: gem_flink_basic results: parsing output: 31/ for test: gem_flink_basic results: parsing output: 32/ for test: gem_huc_copy results: parsing output: 33/ for test: gem_linear_blits results: parsing output: 34/ for test: gem_mmap results: parsing output: 35/ for test: gem_mmap_gtt results: parsing output: 36/ for test: gem_render_linear_blits results: parsing output: 37/ for test: gem_render_tiled_blits results: parsing output: 38/ for test: gem_ringfill results: parsing output: 39/ for test: gem_softpin results: parsing output: 40/ for test: gem_softpin results: parsing output: 41/ for test: gem_softpin results: parsing output: 42/ for test: gem_sync results: parsing output: 43/ for test: gem_sync results: parsing output: 44/ for test: gem_tiled_blits results: parsing output: 45/ for test: gem_tiled_fence_blits results: parsing output: 46/ for test: gem_tiled_pread_basic results: parsing output: 47/ for test: gem_wait results: parsing output: 48/ for test: gem_wait results: parsing output: 49/ for test: i915_getparams_basic results: parsing output: 50/ for test: i915_getparams_basic results: parsing output: 51/ for test: i915_hangman results: parsing output: 52/ for test: i915_pciid results: parsing output: 53/ for test: intel_hwmon results: parsing output: 54/ for test: intel_hwmon results: parsing output: 55/ for test: kms_addfb_basic results: parsing output: 56/ for test: kms_addfb_basic results: parsing output: 57/ for test: kms_addfb_basic results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: kms_addfb_basic results: parsing output: 61/ for test: kms_addfb_basic results: parsing output: 62/ for test: kms_addfb_basic results: parsing output: 63/ for test: kms_addfb_basic results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: kms_addfb_basic results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: kms_addfb_basic results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: kms_addfb_basic results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: kms_addfb_basic results: parsing output: 76/ for test: kms_addfb_basic results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: kms_addfb_basic results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: kms_addfb_basic results: parsing output: 81/ for test: kms_addfb_basic results: parsing output: 82/ for test: kms_addfb_basic results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: kms_addfb_basic results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_addfb_basic results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: kms_addfb_basic results: parsing output: 89/ for test: kms_addfb_basic results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: kms_addfb_basic results: parsing output: 92/ for test: kms_addfb_basic results: parsing output: 93/ for test: kms_busy results: parsing output: 94/ for test: kms_prop_blob results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: kms_cursor_legacy results: parsing output: 102/ for test: kms_cursor_legacy results: parsing output: 103/ for test: kms_dsc results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: kms_force_connector_basic results: parsing output: 109/ for test: kms_force_connector_basic results: parsing output: 110/ for test: kms_force_connector_basic results: parsing output: 111/ for test: kms_force_connector_basic results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_hdmi_inject results: parsing output: 114/ for test: kms_pipe_crc_basic results: parsing output: 115/ for test: kms_pipe_crc_basic results: parsing output: 116/ for test: kms_pipe_crc_basic results: parsing output: 117/ for test: kms_pipe_crc_basic results: parsing output: 118/ for test: kms_pipe_crc_basic results: parsing output: 119/ for test: kms_pipe_crc_basic results: parsing output: 120/ for test: kms_pipe_crc_basic results: parsing output: 121/ for test: kms_pm_backlight results: parsing output: 122/ for test: kms_pm_rpm results: parsing output: 123/ for test: kms_pm_rpm results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: kms_setmode results: parsing output: 129/ for test: i915_pm_rps results: parsing output: 130/ for test: prime_self_import results: parsing output: 131/ for test: prime_self_import results: parsing output: 132/ for test: prime_self_import results: parsing output: 133/ for test: prime_self_import results: parsing output: 134/ for test: prime_self_import results: parsing output: 135/ for test: prime_self_import results: parsing output: 136/ for test: prime_vgem results: parsing output: 137/ for test: prime_vgem results: parsing output: 138/ for test: prime_vgem results: parsing output: 139/ for test: prime_vgem results: parsing output: 140/ for test: prime_vgem results: parsing output: 141/ for test: prime_vgem results: parsing output: 142/ for test: vgem_basic results: parsing output: 143/ for test: vgem_basic results: parsing output: 144/ for test: vgem_basic results: parsing output: 145/ for test: vgem_basic results: parsing output: 146/ for test: vgem_basic results: parsing output: 147/ for test: vgem_basic results: parsing output: 148/ for test: vgem_basic results: parsing output: 149/ for test: vgem_basic results: parsing output: 150/ for test: vgem_basic results: parsing output: 151/ for test: vgem_basic results: parsing output: 152/ for test: core_hotunplug results: parsing output: 153/ for test: vgem_basic results: parsing output: 154/ for test: i915_module_load results: parsing output: 155/ for test: gem_lmem_swapping results: parsing output: 156/ for test: gem_lmem_swapping results: parsing output: 157/ for test: gem_lmem_swapping results: parsing output: 158/ for test: gem_lmem_swapping results: parsing output: 159/ for test: i915_pm_rpm results: parsing output: 160/ for test: i915_selftest results: parsing output: 161/ for test: dmabuf Done.