[37.228979] Initializing watchdogs [37.229093] /dev/watchdog0 [37.241174] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a78 Intel Tigerlake (Gen12) Tiger Lake-LP GT2 [UHD Graphics G4] [37.244725] [001/161] (960s left) i915_module_load (load) [37.488424] Starting subtest: load [38.614823] Subtest load: SUCCESS (1.128s) [38.643619] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [38.645422] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [38.650676] [002/161] (959s left) core_auth (basic-auth) [38.732300] Starting subtest: basic-auth [38.734026] Subtest basic-auth: SUCCESS (0.001s) [38.793663] [003/161] (959s left) debugfs_test (read_all_entries) [38.838494] Starting subtest: read_all_entries [38.913946] Subtest read_all_entries: SUCCESS (0.075s) [39.019241] [004/161] (958s left) debugfs_test (basic-hwmon) [39.060350] Starting subtest: basic-hwmon [39.062460] Subtest basic-hwmon: SKIP (0.000s) [39.167008] [005/161] (958s left) debugfs_test (sysfs) [39.208926] Starting subtest: sysfs [39.250158] Subtest sysfs: SUCCESS (0.041s) [39.350566] [006/161] (958s left) fbdev (eof) [39.397834] Starting subtest: eof [39.399474] Subtest eof: SUCCESS (0.000s) [39.442928] [007/161] (958s left) fbdev (info) [39.477973] Starting subtest: info [39.478941] Subtest info: SUCCESS (0.000s) [39.524666] [008/161] (958s left) fbdev (nullptr) [39.572198] Starting subtest: nullptr [39.573248] Subtest nullptr: SUCCESS (0.000s) [39.616548] [009/161] (958s left) fbdev (read) [39.655489] Starting subtest: read [40.301771] Subtest read: SUCCESS (0.644s) [40.341386] [010/161] (957s left) fbdev (write) [40.380126] Starting subtest: write [40.821052] Subtest write: SUCCESS (0.438s) [40.866663] [011/161] (957s left) gem_basic (bad-close) [40.905568] Starting subtest: bad-close [40.907694] Subtest bad-close: SUCCESS (0.000s) [40.961563] [012/161] (957s left) gem_basic (create-close) [40.997736] Starting subtest: create-close [40.999949] Subtest create-close: SUCCESS (0.000s) [41.073153] [013/161] (957s left) gem_basic (create-fd-close) [41.115004] Starting subtest: create-fd-close [41.118327] Subtest create-fd-close: SUCCESS (0.000s) [41.188432] [014/161] (956s left) gem_busy (busy@all-engines) [41.235535] Starting subtest: busy [41.237387] Starting dynamic subtest: all-engines [41.268560] Dynamic subtest all-engines: SUCCESS (0.034s) [41.269716] Subtest busy: SUCCESS (0.034s) [41.614710] [015/161] (956s left) gem_close_race (basic-process) [41.663507] Starting subtest: basic-process [41.729556] Subtest basic-process: SUCCESS (0.065s) [41.900572] [016/161] (956s left) gem_close_race (basic-threads) [41.950169] Starting subtest: basic-threads [43.171486] Subtest basic-threads: SUCCESS (1.223s) [43.342346] [017/161] (954s left) gem_ctx_create (basic) [43.388191] Starting subtest: basic [43.389290] Subtest basic: SUCCESS (0.000s) [43.560257] [018/161] (954s left) gem_ctx_create (basic-files) [43.606318] Starting subtest: basic-files [45.619233] Subtest basic-files: SUCCESS (2.013s) [45.794190] [019/161] (952s left) gem_ctx_exec (basic) [45.834541] Starting subtest: basic [45.837329] Subtest basic: SUCCESS (0.003s) [45.928834] [020/161] (952s left) gem_exec_basic (basic) [45.972947] Starting subtest: basic [45.974295] Starting dynamic subtest: rcs0-smem [45.975491] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [45.980634] Starting dynamic subtest: bcs0-smem [45.981664] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [45.986656] Starting dynamic subtest: vcs0-smem [45.987675] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [45.992510] Starting dynamic subtest: vecs0-smem [45.993532] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [45.994537] Subtest basic: SUCCESS (0.003s) [46.149182] [021/161] (952s left) gem_exec_create (basic) [46.196730] Starting subtest: basic [46.198171] Starting dynamic subtest: smem [48.233743] Dynamic subtest smem: SUCCESS (2.037s) [48.234821] Subtest basic: SUCCESS (2.037s) [48.406109] [022/161] (949s left) gem_exec_fence (basic-busy) [48.584599] Starting subtest: basic-busy [48.586062] Starting dynamic subtest: rcs0 [48.614885] Dynamic subtest rcs0: SUCCESS (0.030s) [48.624987] Starting dynamic subtest: bcs0 [48.645254] Dynamic subtest bcs0: SUCCESS (0.029s) [48.656187] Starting dynamic subtest: vcs0 [48.665640] Dynamic subtest vcs0: SUCCESS (0.021s) [48.673968] Starting dynamic subtest: vecs0 [48.686441] Dynamic subtest vecs0: SUCCESS (0.021s) [48.687817] Subtest basic-busy: SUCCESS (0.102s) [49.168636] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [49.170645] [023/161] (949s left) gem_exec_fence (basic-wait) [49.347741] Starting subtest: basic-wait [49.349153] Starting dynamic subtest: rcs0 [49.368665] Dynamic subtest rcs0: SUCCESS (0.021s) [49.378250] Starting dynamic subtest: bcs0 [49.404214] Dynamic subtest bcs0: SUCCESS (0.035s) [49.416498] Starting dynamic subtest: vcs0 [49.429342] Dynamic subtest vcs0: SUCCESS (0.025s) [49.439638] Starting dynamic subtest: vecs0 [49.454091] Dynamic subtest vecs0: SUCCESS (0.024s) [49.455684] Subtest basic-wait: SUCCESS (0.106s) [49.903877] [024/161] (948s left) gem_exec_fence (basic-await) [50.082404] Starting subtest: basic-await [50.084141] Starting dynamic subtest: rcs0 [50.167515] Dynamic subtest rcs0: SUCCESS (0.083s) [50.178657] Starting dynamic subtest: bcs0 [50.256221] Dynamic subtest bcs0: SUCCESS (0.088s) [50.268602] Starting dynamic subtest: vcs0 [50.348947] Dynamic subtest vcs0: SUCCESS (0.092s) [50.362141] Starting dynamic subtest: vecs0 [50.441147] Dynamic subtest vecs0: SUCCESS (0.092s) [50.442774] Subtest basic-await: SUCCESS (0.357s) [50.897868] [025/161] (947s left) gem_exec_fence (nb-await) [51.073834] Starting subtest: nb-await [51.075689] Starting dynamic subtest: rcs0 [51.135616] Dynamic subtest rcs0: SUCCESS (0.059s) [51.147597] Starting dynamic subtest: bcs0 [51.194838] Dynamic subtest bcs0: SUCCESS (0.061s) [51.207450] Starting dynamic subtest: vcs0 [51.260378] Dynamic subtest vcs0: SUCCESS (0.062s) [51.272293] Starting dynamic subtest: vecs0 [51.320534] Dynamic subtest vecs0: SUCCESS (0.061s) [51.322066] Subtest nb-await: SUCCESS (0.245s) [51.778451] [026/161] (946s left) gem_exec_gttfill (basic) [51.827336] Starting subtest: basic [56.958031] Subtest basic: SUCCESS (5.129s) [57.122585] [027/161] (941s left) gem_exec_parallel (engines) [57.228526] Starting subtest: engines [57.229744] Starting dynamic subtest: basic [58.971121] Dynamic subtest basic: SUCCESS (1.703s) [58.976717] Starting dynamic subtest: contexts [65.020737] Dynamic subtest contexts: SUCCESS (6.089s) [65.031291] Starting dynamic subtest: fds [71.386141] Dynamic subtest fds: SUCCESS (6.349s) [71.401732] Starting dynamic subtest: userptr [73.493107] Dynamic subtest userptr: SUCCESS (2.082s) [73.494694] Subtest engines: SUCCESS (16.223s) [73.635594] [028/161] (924s left) gem_exec_store (basic) [73.683257] Starting subtest: basic [73.742159] Subtest basic: SUCCESS (0.058s) [73.914400] [029/161] (924s left) gem_flink_basic (bad-flink) [73.951309] Starting subtest: bad-flink [73.952404] Subtest bad-flink: SUCCESS (0.000s) [74.009193] [030/161] (924s left) gem_flink_basic (bad-open) [74.047038] Starting subtest: bad-open [74.048104] Subtest bad-open: SUCCESS (0.000s) [74.100740] [031/161] (924s left) gem_flink_basic (basic) [74.138622] Starting subtest: basic [74.140321] Subtest basic: SUCCESS (0.000s) [74.235296] [032/161] (924s left) gem_flink_basic (double-flink) [74.274048] Starting subtest: double-flink [74.275371] Subtest double-flink: SUCCESS (0.000s) [74.359524] [033/161] (924s left) gem_flink_basic (flink-lifetime) [74.398321] Starting subtest: flink-lifetime [74.399610] Subtest flink-lifetime: SUCCESS (0.001s) [74.465284] [034/161] (924s left) gem_huc_copy (huc-copy) [74.506600] Starting subtest: huc-copy [74.508819] Subtest huc-copy: SKIP (0.000s) [74.619598] [035/161] (924s left) gem_linear_blits (basic) [74.723359] Starting subtest: basic [74.733647] Subtest basic: SUCCESS (0.007s) [74.854788] [036/161] (924s left) gem_mmap (basic) [74.956539] Starting subtest: basic [74.961562] Subtest basic: SUCCESS (0.000s) [75.033154] [037/161] (923s left) gem_mmap_gtt (basic) [75.072347] Starting subtest: basic [75.073484] Subtest basic: SUCCESS (0.001s) [75.121026] [038/161] (923s left) gem_render_linear_blits (basic) [75.162496] Starting subtest: basic [75.191267] Subtest basic: SUCCESS (0.028s) [75.258644] [039/161] (923s left) gem_render_tiled_blits (basic) [75.300615] Starting subtest: basic [75.323428] Subtest basic: SUCCESS (0.023s) [75.378820] [040/161] (923s left) gem_ringfill (basic-all) [75.552983] Starting subtest: basic-all [76.740068] Subtest basic-all: SUCCESS (1.140s) [76.785265] [041/161] (922s left) gem_softpin (allocator-basic) [76.826271] Starting subtest: allocator-basic [76.893897] Subtest allocator-basic: SUCCESS (0.065s) [77.006298] [042/161] (922s left) gem_softpin (allocator-basic-reserve) [77.046441] Starting subtest: allocator-basic-reserve [77.113963] Subtest allocator-basic-reserve: SUCCESS (0.065s) [77.205160] [043/161] (921s left) gem_softpin (safe-alignment) [77.249263] Starting subtest: safe-alignment [77.258702] Subtest safe-alignment: SUCCESS (0.008s) [77.347463] [044/161] (921s left) gem_sync (basic-all) [77.398172] Starting subtest: basic-all [79.483391] Subtest basic-all: SUCCESS (2.054s) [79.616985] [045/161] (919s left) gem_sync (basic-each) [79.663479] Starting subtest: basic-each [81.752551] Subtest basic-each: SUCCESS (2.090s) [81.948801] [046/161] (917s left) gem_tiled_blits (basic) [82.042631] Starting subtest: basic [82.067651] Subtest basic: SUCCESS (0.022s) [82.204569] [047/161] (917s left) gem_tiled_fence_blits (basic) [82.371062] Starting subtest: basic [82.394189] Subtest basic: SUCCESS (0.023s) [82.478851] [048/161] (916s left) gem_tiled_pread_basic [82.695884] [049/161] (916s left) gem_wait (busy@all-engines) [82.748873] Starting subtest: busy [82.750030] Starting dynamic subtest: all-engines [83.270500] Dynamic subtest all-engines: SUCCESS (0.522s) [83.271567] Subtest busy: SUCCESS (0.522s) [83.474872] [050/161] (915s left) gem_wait (wait@all-engines) [83.526572] Starting subtest: wait [83.527754] Starting dynamic subtest: all-engines [84.561853] Dynamic subtest all-engines: SUCCESS (1.035s) [84.563748] Subtest wait: SUCCESS (1.035s) [84.764710] [051/161] (914s left) i915_getparams_basic (basic-eu-total) [84.802711] Starting subtest: basic-eu-total [84.804879] Subtest basic-eu-total: SUCCESS (0.000s) [84.865876] [052/161] (914s left) i915_getparams_basic (basic-subslice-total) [84.904410] Starting subtest: basic-subslice-total [84.907345] Subtest basic-subslice-total: SUCCESS (0.000s) [84.963383] [053/161] (914s left) i915_hangman (error-state-basic) [85.012444] Starting subtest: error-state-basic [85.018293] Subtest error-state-basic: SUCCESS (0.005s) [85.077286] [054/161] (914s left) i915_pciid [85.168926] [055/161] (914s left) kms_addfb_basic (addfb25-4-tiled) [85.267650] Starting subtest: addfb25-4-tiled [85.268737] Subtest addfb25-4-tiled: SUCCESS (0.000s) [85.344321] [056/161] (914s left) kms_addfb_basic (addfb25-bad-modifier) [85.435700] Starting subtest: addfb25-bad-modifier [85.436866] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [85.503866] [057/161] (914s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [85.595308] Starting subtest: addfb25-framebuffer-vs-set-tiling [85.596321] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [85.667957] [058/161] (914s left) kms_addfb_basic (addfb25-modifier-no-flag) [85.758593] Starting subtest: addfb25-modifier-no-flag [85.759688] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [85.849339] [059/161] (913s left) kms_addfb_basic (addfb25-x-tiled-legacy) [85.940557] Starting subtest: addfb25-x-tiled-legacy [85.941639] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [86.023937] [060/161] (913s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [86.118752] Starting subtest: addfb25-x-tiled-mismatch-legacy [86.120292] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [86.200778] [061/161] (913s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [86.292593] Starting subtest: addfb25-yf-tiled-legacy [86.293680] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [86.361080] [062/161] (913s left) kms_addfb_basic (addfb25-y-tiled-legacy) [86.455245] Starting subtest: addfb25-y-tiled-legacy [86.456241] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [86.535380] [063/161] (913s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [86.630243] Starting subtest: addfb25-y-tiled-small-legacy [86.631275] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [86.702285] [064/161] (913s left) kms_addfb_basic (bad-pitch-0) [86.740903] Starting subtest: bad-pitch-0 [86.742579] Subtest bad-pitch-0: SUCCESS (0.000s) [86.874341] [065/161] (913s left) kms_addfb_basic (bad-pitch-1024) [86.914024] Starting subtest: bad-pitch-1024 [86.915060] Subtest bad-pitch-1024: SUCCESS (0.000s) [87.044109] [066/161] (912s left) kms_addfb_basic (bad-pitch-128) [87.083270] Starting subtest: bad-pitch-128 [87.084383] Subtest bad-pitch-128: SUCCESS (0.000s) [87.224698] [067/161] (912s left) kms_addfb_basic (bad-pitch-256) [87.262919] Starting subtest: bad-pitch-256 [87.264119] Subtest bad-pitch-256: SUCCESS (0.000s) [87.394298] [068/161] (912s left) kms_addfb_basic (bad-pitch-32) [87.435720] Starting subtest: bad-pitch-32 [87.436900] Subtest bad-pitch-32: SUCCESS (0.000s) [87.588923] [069/161] (912s left) kms_addfb_basic (bad-pitch-63) [87.626176] Starting subtest: bad-pitch-63 [87.627375] Subtest bad-pitch-63: SUCCESS (0.000s) [87.754740] [070/161] (912s left) kms_addfb_basic (bad-pitch-65536) [87.793064] Starting subtest: bad-pitch-65536 [87.794870] Subtest bad-pitch-65536: SUCCESS (0.000s) [87.920611] [071/161] (912s left) kms_addfb_basic (bad-pitch-999) [87.958119] Starting subtest: bad-pitch-999 [87.959310] Subtest bad-pitch-999: SUCCESS (0.000s) [88.110871] [072/161] (912s left) kms_addfb_basic (basic) [88.149914] Starting subtest: basic [88.151061] Subtest basic: SUCCESS (0.000s) [88.298840] [073/161] (911s left) kms_addfb_basic (basic-x-tiled-legacy) [88.337951] Starting subtest: basic-x-tiled-legacy [88.339079] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [88.466089] [074/161] (911s left) kms_addfb_basic (basic-y-tiled-legacy) [88.504793] Starting subtest: basic-y-tiled-legacy [88.505918] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [88.650225] [075/161] (911s left) kms_addfb_basic (bo-too-small) [88.741390] Starting subtest: bo-too-small [88.742716] Subtest bo-too-small: SUCCESS (0.000s) [88.810235] [076/161] (911s left) kms_addfb_basic (bo-too-small-due-to-tiling) [88.902284] Starting subtest: bo-too-small-due-to-tiling [88.903275] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [88.976992] [077/161] (911s left) kms_addfb_basic (clobberred-modifier) [89.016230] Starting subtest: clobberred-modifier [89.017402] Subtest clobberred-modifier: SUCCESS (0.000s) [89.150712] [078/161] (911s left) kms_addfb_basic (framebuffer-vs-set-tiling) [89.189405] Starting subtest: framebuffer-vs-set-tiling [89.190497] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [89.327143] [079/161] (911s left) kms_addfb_basic (invalid-get-prop) [89.367559] Starting subtest: invalid-get-prop [89.368570] Subtest invalid-get-prop: SUCCESS (0.000s) [89.496207] [080/161] (910s left) kms_addfb_basic (invalid-get-prop-any) [89.536539] Starting subtest: invalid-get-prop-any [89.537658] Subtest invalid-get-prop-any: SUCCESS (0.000s) [89.676327] [081/161] (910s left) kms_addfb_basic (invalid-set-prop) [89.714809] Starting subtest: invalid-set-prop [89.716438] Subtest invalid-set-prop: SUCCESS (0.000s) [89.838882] [082/161] (910s left) kms_addfb_basic (invalid-set-prop-any) [89.879728] Starting subtest: invalid-set-prop-any [89.880768] Subtest invalid-set-prop-any: SUCCESS (0.000s) [90.002292] [083/161] (910s left) kms_addfb_basic (no-handle) [90.040880] Starting subtest: no-handle [90.041992] Subtest no-handle: SUCCESS (0.000s) [90.160904] [084/161] (910s left) kms_addfb_basic (size-max) [90.252557] Starting subtest: size-max [90.253614] Subtest size-max: SUCCESS (0.000s) [90.341075] [085/161] (910s left) kms_addfb_basic (small-bo) [90.431380] Starting subtest: small-bo [90.432513] Subtest small-bo: SUCCESS (0.000s) [90.493743] [086/161] (910s left) kms_addfb_basic (tile-pitch-mismatch) [90.535504] Starting subtest: tile-pitch-mismatch [90.537311] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [90.661286] [087/161] (909s left) kms_addfb_basic (too-high) [90.753560] Starting subtest: too-high [90.754639] Subtest too-high: SUCCESS (0.001s) [90.830678] [088/161] (909s left) kms_addfb_basic (too-wide) [90.921566] Starting subtest: too-wide [90.922656] Subtest too-wide: SUCCESS (0.000s) [91.008721] [089/161] (909s left) kms_addfb_basic (unused-handle) [91.047367] Starting subtest: unused-handle [91.048522] Subtest unused-handle: SUCCESS (0.000s) [91.186655] [090/161] (909s left) kms_addfb_basic (unused-modifier) [91.227569] Starting subtest: unused-modifier [91.228636] Subtest unused-modifier: SUCCESS (0.000s) [91.343680] [091/161] (909s left) kms_addfb_basic (unused-offsets) [91.383373] Starting subtest: unused-offsets [91.384440] Subtest unused-offsets: SUCCESS (0.000s) [91.505617] [092/161] (909s left) kms_addfb_basic (unused-pitches) [91.544717] Starting subtest: unused-pitches [91.545890] Subtest unused-pitches: SUCCESS (0.000s) [91.673442] [093/161] (909s left) kms_busy (basic) [91.769436] Starting subtest: basic [91.771138] Starting dynamic subtest: flip [92.149461] Dynamic subtest flip: SUCCESS (0.377s) [92.157447] Starting dynamic subtest: modeset [92.676137] Dynamic subtest modeset: SUCCESS (0.530s) [92.677329] Subtest basic: SUCCESS (0.909s) [92.788032] [094/161] (908s left) kms_prop_blob (basic) [92.833616] Starting subtest: basic [92.834826] Subtest basic: SUCCESS (0.000s) [92.888739] [095/161] (908s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [92.986073] Starting subtest: basic-busy-flip-before-cursor-atomic [92.988173] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [93.043757] [096/161] (907s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [93.134721] Starting subtest: basic-busy-flip-before-cursor-legacy [93.136978] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [93.186101] [097/161] (907s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [93.278635] Starting subtest: basic-flip-after-cursor-atomic [93.765964] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.485s) [93.899668] [098/161] (907s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [93.996871] Starting subtest: basic-flip-after-cursor-legacy [94.486681] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.487s) [94.612123] [099/161] (906s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [94.705667] Starting subtest: basic-flip-after-cursor-varying-size [95.197330] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.489s) [95.313899] [100/161] (905s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [95.407656] Starting subtest: basic-flip-before-cursor-atomic [95.891885] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.483s) [96.023284] [101/161] (905s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [96.115652] Starting subtest: basic-flip-before-cursor-legacy [96.604625] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.486s) [96.736694] [102/161] (904s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [96.832544] Starting subtest: basic-flip-before-cursor-varying-size [97.331614] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.498s) [97.457526] [103/161] (903s left) kms_dsc (dsc-basic) [97.555840] Starting subtest: dsc-basic [97.563672] Subtest dsc-basic: SKIP (0.000s) [97.610929] [104/161] (903s left) kms_flip (basic-flip-vs-dpms) [97.705709] Starting subtest: basic-flip-vs-dpms [97.706811] Starting dynamic subtest: A-HDMI-A1 [98.448901] Dynamic subtest A-HDMI-A1: SUCCESS (0.741s) [98.463834] Starting dynamic subtest: B-HDMI-A1 [99.095235] Dynamic subtest B-HDMI-A1: SUCCESS (0.645s) [99.103681] Starting dynamic subtest: C-HDMI-A1 [99.726972] Dynamic subtest C-HDMI-A1: SUCCESS (0.630s) [99.741943] Starting dynamic subtest: D-HDMI-A1 [100.390586] Dynamic subtest D-HDMI-A1: SUCCESS (0.660s) [100.394496] Subtest basic-flip-vs-dpms: SUCCESS (2.685s) [100.509606] [105/161] (900s left) kms_flip (basic-flip-vs-modeset) [100.618232] Starting subtest: basic-flip-vs-modeset [100.621103] Starting dynamic subtest: A-HDMI-A1 [101.290249] Dynamic subtest A-HDMI-A1: SUCCESS (0.669s) [101.298120] Starting dynamic subtest: B-HDMI-A1 [101.942618] Dynamic subtest B-HDMI-A1: SUCCESS (0.648s) [101.950189] Starting dynamic subtest: C-HDMI-A1 [102.664371] Dynamic subtest C-HDMI-A1: SUCCESS (0.717s) [102.675766] Starting dynamic subtest: D-HDMI-A1 [103.295964] Dynamic subtest D-HDMI-A1: SUCCESS (0.630s) [103.297951] Subtest basic-flip-vs-modeset: SUCCESS (2.678s) [103.433850] [106/161] (897s left) kms_flip (basic-flip-vs-wf_vblank) [103.551280] Starting subtest: basic-flip-vs-wf_vblank [103.554118] Starting dynamic subtest: A-HDMI-A1 [104.401400] Dynamic subtest A-HDMI-A1: SUCCESS (0.847s) [104.424823] Starting dynamic subtest: B-HDMI-A1 [105.250221] Dynamic subtest B-HDMI-A1: SUCCESS (0.842s) [105.271347] Starting dynamic subtest: C-HDMI-A1 [106.088588] Dynamic subtest C-HDMI-A1: SUCCESS (0.837s) [106.107449] Starting dynamic subtest: D-HDMI-A1 [106.917822] Dynamic subtest D-HDMI-A1: SUCCESS (0.823s) [106.924838] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.374s) [107.097390] [107/161] (894s left) kms_flip (basic-plain-flip) [107.197084] Starting subtest: basic-plain-flip [107.200857] Starting dynamic subtest: A-HDMI-A1 [107.893526] Dynamic subtest A-HDMI-A1: SUCCESS (0.692s) [107.912728] Starting dynamic subtest: B-HDMI-A1 [108.565900] Dynamic subtest B-HDMI-A1: SUCCESS (0.666s) [108.585896] Starting dynamic subtest: C-HDMI-A1 [109.265752] Dynamic subtest C-HDMI-A1: SUCCESS (0.696s) [109.283873] Starting dynamic subtest: D-HDMI-A1 [109.957797] Dynamic subtest D-HDMI-A1: SUCCESS (0.687s) [109.963080] Subtest basic-plain-flip: SUCCESS (2.765s) [110.105731] [108/161] (891s left) kms_force_connector_basic (force-connector-state) [110.243942] Starting subtest: force-connector-state [110.545985] Subtest force-connector-state: SUCCESS (0.303s) [110.841333] [109/161] (890s left) kms_force_connector_basic (force-edid) [110.976548] Starting subtest: force-edid [111.136350] Subtest force-edid: SUCCESS (0.157s) [111.292294] [110/161] (890s left) kms_force_connector_basic (force-load-detect) [111.436754] Starting subtest: force-load-detect [111.439744] Subtest force-load-detect: SKIP (0.000s) [111.591485] [111/161] (889s left) kms_force_connector_basic (prune-stale-modes) [111.725213] Starting subtest: prune-stale-modes [111.880285] Subtest prune-stale-modes: SUCCESS (0.157s) [112.069227] [112/161] (889s left) kms_frontbuffer_tracking (basic) [112.168241] Starting subtest: basic [113.768201] Subtest basic: SUCCESS (1.602s) [113.874091] [113/161] (887s left) kms_hdmi_inject (inject-audio) [113.961808] Starting subtest: inject-audio [114.123272] Subtest inject-audio: SUCCESS (0.163s) [114.257751] [114/161] (887s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [114.353530] Starting subtest: compare-crc-sanitycheck-xr24 [114.354700] Starting dynamic subtest: pipe-A-HDMI-A-1 [114.625779] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.271s) [114.635400] Starting dynamic subtest: pipe-B-HDMI-A-1 [114.892206] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.263s) [114.900263] Starting dynamic subtest: pipe-C-HDMI-A-1 [115.159584] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.265s) [115.167177] Starting dynamic subtest: pipe-D-HDMI-A-1 [115.446220] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.283s) [115.447380] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.093s) [115.567554] [115/161] (886s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [115.669053] Starting subtest: compare-crc-sanitycheck-nv12 [115.672128] Starting dynamic subtest: pipe-A-HDMI-A-1 [116.034197] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.361s) [116.040697] Starting dynamic subtest: pipe-B-HDMI-A-1 [116.407984] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.371s) [116.414172] Starting dynamic subtest: pipe-C-HDMI-A-1 [116.775547] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.366s) [116.783663] Starting dynamic subtest: pipe-D-HDMI-A-1 [117.101722] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.323s) [117.102820] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.432s) [117.225589] [116/161] (884s left) kms_pipe_crc_basic (hang-read-crc) [117.325556] Starting subtest: hang-read-crc [117.326666] Starting dynamic subtest: pipe-A-HDMI-A-1 [118.044164] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.717s) [118.052254] Starting dynamic subtest: pipe-B-HDMI-A-1 [118.711343] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.666s) [118.721476] Starting dynamic subtest: pipe-C-HDMI-A-1 [119.366320] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.653s) [119.375952] Starting dynamic subtest: pipe-D-HDMI-A-1 [119.995042] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.623s) [119.996469] Subtest hang-read-crc: SUCCESS (2.668s) [120.112101] [117/161] (881s left) kms_pipe_crc_basic (nonblocking-crc) [120.220416] Starting subtest: nonblocking-crc [120.221593] Starting dynamic subtest: pipe-A-HDMI-A-1 [120.599884] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.379s) [120.609961] Starting dynamic subtest: pipe-B-HDMI-A-1 [120.942532] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.339s) [120.950341] Starting dynamic subtest: pipe-C-HDMI-A-1 [121.316855] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.373s) [121.328363] Starting dynamic subtest: pipe-D-HDMI-A-1 [121.677097] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.357s) [121.678217] Subtest nonblocking-crc: SUCCESS (1.458s) [121.784575] [118/161] (879s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [121.883850] Starting subtest: nonblocking-crc-frame-sequence [121.888755] Starting dynamic subtest: pipe-A-HDMI-A-1 [122.248677] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.362s) [122.255334] Starting dynamic subtest: pipe-B-HDMI-A-1 [122.625448] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.376s) [122.636067] Starting dynamic subtest: pipe-C-HDMI-A-1 [122.976919] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.347s) [122.983296] Starting dynamic subtest: pipe-D-HDMI-A-1 [123.322214] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.342s) [123.324188] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.437s) [123.429539] [119/161] (878s left) kms_pipe_crc_basic (read-crc) [123.524440] Starting subtest: read-crc [123.525571] Starting dynamic subtest: pipe-A-HDMI-A-1 [123.883259] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.357s) [123.892251] Starting dynamic subtest: pipe-B-HDMI-A-1 [124.238170] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.352s) [124.244735] Starting dynamic subtest: pipe-C-HDMI-A-1 [124.551367] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.311s) [124.561263] Starting dynamic subtest: pipe-D-HDMI-A-1 [124.870521] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.317s) [124.871792] Subtest read-crc: SUCCESS (1.347s) [124.978522] [120/161] (876s left) kms_pipe_crc_basic (read-crc-frame-sequence) [125.075404] Starting subtest: read-crc-frame-sequence [125.076531] Starting dynamic subtest: pipe-A-HDMI-A-1 [125.402025] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.325s) [125.409815] Starting dynamic subtest: pipe-B-HDMI-A-1 [125.707808] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.305s) [125.718427] Starting dynamic subtest: pipe-C-HDMI-A-1 [126.019602] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.309s) [126.029742] Starting dynamic subtest: pipe-D-HDMI-A-1 [126.331539] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.309s) [126.332644] Subtest read-crc-frame-sequence: SUCCESS (1.257s) [126.436016] [121/161] (875s left) kms_pm_backlight (basic-brightness) [126.538134] Subtest basic-brightness: SKIP (0.000s) [126.578286] [122/161] (875s left) kms_pm_rpm (basic-pci-d3-state) [128.006599] Starting subtest: basic-pci-d3-state [129.303354] Subtest basic-pci-d3-state: SUCCESS (1.298s) [129.411923] [123/161] (872s left) kms_pm_rpm (basic-rte) [129.451575] Starting subtest: basic-rte [132.113765] Subtest basic-rte: SUCCESS (2.663s) [133.516143] [124/161] (868s left) kms_psr (psr-primary-page-flip) [133.613695] Subtest psr-primary-page-flip: SKIP (0.000s) [133.659681] [125/161] (868s left) kms_psr (psr-cursor-plane-move) [133.750541] Subtest psr-cursor-plane-move: SKIP (0.000s) [133.787664] [126/161] (868s left) kms_psr (psr-sprite-plane-onoff) [133.888043] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [133.928561] [127/161] (868s left) kms_psr (psr-primary-mmap-gtt) [134.022668] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [134.067491] [128/161] (868s left) kms_setmode (basic-clone-single-crtc) [134.107693] Starting subtest: basic-clone-single-crtc [134.110895] Subtest basic-clone-single-crtc: SKIP (0.000s) [134.169548] [129/161] (867s left) i915_pm_rps (basic-api) [134.211925] Starting subtest: basic-api [134.215253] Subtest basic-api: SUCCESS (0.002s) [134.276360] [130/161] (867s left) prime_self_import (basic-llseek-bad) [134.315531] Starting subtest: basic-llseek-bad [134.317601] Subtest basic-llseek-bad: SUCCESS (0.002s) [134.396564] [131/161] (867s left) prime_self_import (basic-llseek-size) [134.437508] Starting subtest: basic-llseek-size [134.439580] Subtest basic-llseek-size: SUCCESS (0.002s) [134.524320] [132/161] (867s left) prime_self_import (basic-with_fd_dup) [134.564470] Starting subtest: basic-with_fd_dup [134.567068] Subtest basic-with_fd_dup: SUCCESS (0.002s) [134.648581] [133/161] (867s left) prime_self_import (basic-with_one_bo) [134.685291] Starting subtest: basic-with_one_bo [134.689119] Subtest basic-with_one_bo: SUCCESS (0.003s) [134.743716] [134/161] (867s left) prime_self_import (basic-with_one_bo_two_files) [134.779723] Starting subtest: basic-with_one_bo_two_files [134.782485] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [134.856681] [135/161] (867s left) prime_self_import (basic-with_two_bos) [134.895506] Starting subtest: basic-with_two_bos [134.897749] Subtest basic-with_two_bos: SUCCESS (0.003s) [134.975907] [136/161] (867s left) prime_vgem (basic-fence-flip) [135.045774] Starting subtest: basic-fence-flip [135.350035] Subtest basic-fence-flip: SUCCESS (0.304s) [135.450321] [137/161] (866s left) prime_vgem (basic-fence-mmap) [135.513162] Starting subtest: basic-fence-mmap [135.536897] Subtest basic-fence-mmap: SUCCESS (0.024s) [135.615734] [138/161] (866s left) prime_vgem (basic-fence-read) [135.688555] Starting subtest: basic-fence-read [135.728415] Subtest basic-fence-read: SUCCESS (0.040s) [135.794426] [139/161] (866s left) prime_vgem (basic-gtt) [135.856636] Starting subtest: basic-gtt [135.865636] Subtest basic-gtt: SUCCESS (0.009s) [135.947571] [140/161] (866s left) prime_vgem (basic-read) [135.996744] Starting subtest: basic-read [136.012995] Subtest basic-read: SUCCESS (0.017s) [136.093540] [141/161] (866s left) prime_vgem (basic-write) [136.157403] Starting subtest: basic-write [136.180391] Subtest basic-write: SUCCESS (0.023s) [136.243565] [142/161] (866s left) vgem_basic (setversion) [136.285173] Starting subtest: setversion [136.287135] Subtest setversion: SUCCESS (0.000s) [136.333331] [143/161] (866s left) vgem_basic (create) [136.376073] Starting subtest: create [136.377231] Subtest create: SUCCESS (0.000s) [136.424924] [144/161] (866s left) vgem_basic (debugfs) [136.467808] Starting subtest: debugfs [136.468911] Subtest debugfs: SUCCESS (0.000s) [136.516594] [145/161] (866s left) vgem_basic (dmabuf-export) [136.560399] Starting subtest: dmabuf-export [136.573202] Subtest dmabuf-export: SUCCESS (0.013s) [136.658383] [146/161] (866s left) vgem_basic (dmabuf-fence) [136.700991] Starting subtest: dmabuf-fence [136.702141] Subtest dmabuf-fence: SUCCESS (0.000s) [136.749668] [147/161] (866s left) vgem_basic (dmabuf-fence-before) [136.793596] Starting subtest: dmabuf-fence-before [136.794665] Subtest dmabuf-fence-before: SUCCESS (0.000s) [136.845055] [148/161] (865s left) vgem_basic (dmabuf-mmap) [136.885033] Starting subtest: dmabuf-mmap [136.891357] Subtest dmabuf-mmap: SUCCESS (0.008s) [136.942032] [149/161] (865s left) vgem_basic (mmap) [136.984291] Starting subtest: mmap [136.988771] Subtest mmap: SUCCESS (0.005s) [137.032328] [150/161] (865s left) vgem_basic (second-client) [137.076022] Starting subtest: second-client [137.092550] Subtest second-client: SUCCESS (0.016s) [137.143485] [151/161] (865s left) vgem_basic (sysfs) [137.185187] Starting subtest: sysfs [137.186183] Subtest sysfs: SUCCESS (0.000s) [137.232615] [152/161] (865s left) core_hotunplug (unbind-rebind) [137.327049] Starting subtest: unbind-rebind [140.498393] Subtest unbind-rebind: SUCCESS (3.173s) [140.531271] [153/161] (862s left) vgem_basic (unload) [140.572708] Starting subtest: unload [169.705663] Subtest unload: SUCCESS (29.085s) [169.744606] [154/161] (833s left) i915_module_load (reload) [169.783398] Starting subtest: reload [171.774888] Subtest reload: SUCCESS (1.991s) [171.836350] [155/161] (831s left) gem_lmem_swapping (basic) [171.904881] Subtest basic: SKIP (0.000s) [171.941216] [156/161] (831s left) gem_lmem_swapping (parallel-random-engines) [171.984884] Subtest parallel-random-engines: SKIP (0.000s) [172.024592] [157/161] (831s left) gem_lmem_swapping (random-engines) [172.071834] Subtest random-engines: SKIP (0.000s) [172.109533] [158/161] (831s left) gem_lmem_swapping (verify-random) [172.154925] Subtest verify-random: SKIP (0.000s) [172.190754] [159/161] (831s left) i915_pm_rpm (module-reload) [173.693697] Starting subtest: module-reload [180.963765] Subtest module-reload: SUCCESS (7.268s) [180.991857] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [180.992687] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [180.994807] [160/161] (822s left) i915_selftest (live) [181.041878] Starting subtest: live [181.042933] Starting dynamic subtest: sanitycheck [182.248622] Dynamic subtest sanitycheck: SUCCESS (1.203s) [182.262878] Starting dynamic subtest: uncore [183.474669] Dynamic subtest uncore: SUCCESS (1.224s) [183.489138] Starting dynamic subtest: workarounds [185.078525] Dynamic subtest workarounds: SUCCESS (1.602s) [185.089531] Starting dynamic subtest: gt_engines [186.736456] Dynamic subtest gt_engines: SUCCESS (1.656s) [186.747465] Starting dynamic subtest: gt_timelines [193.299064] Dynamic subtest gt_timelines: SUCCESS (6.560s) [193.309042] Starting dynamic subtest: gt_contexts [194.600925] Dynamic subtest gt_contexts: SUCCESS (1.300s) [194.615136] Starting dynamic subtest: gt_lrc [198.235775] Dynamic subtest gt_lrc: SUCCESS (3.633s) [198.246641] Starting dynamic subtest: gt_mocs [199.535586] Dynamic subtest gt_mocs: SUCCESS (1.298s) [199.545638] Starting dynamic subtest: gt_pm [217.289817] Dynamic subtest gt_pm: SUCCESS (17.752s) [217.300877] Starting dynamic subtest: gt_heartbeat [218.464707] Dynamic subtest gt_heartbeat: SUCCESS (1.172s) [218.475775] Starting dynamic subtest: gt_tlb [220.655499] Dynamic subtest gt_tlb: SUCCESS (2.188s) [220.671244] Starting dynamic subtest: requests [228.152118] Dynamic subtest requests: SUCCESS (7.495s) [228.163848] Starting dynamic subtest: migrate [232.317622] Dynamic subtest migrate: SUCCESS (4.164s) [232.331921] Starting dynamic subtest: active [233.530571] Dynamic subtest active: SUCCESS (1.211s) [233.541070] Starting dynamic subtest: objects [235.180716] Dynamic subtest objects: SUCCESS (1.648s) [235.191309] Starting dynamic subtest: mman [239.731559] Dynamic subtest mman: SUCCESS (4.549s) [239.746171] Starting dynamic subtest: dmabuf [240.988711] Dynamic subtest dmabuf: SUCCESS (1.255s) [240.999205] Starting dynamic subtest: vma [242.199422] Dynamic subtest vma: SUCCESS (1.209s) [242.209074] Starting dynamic subtest: coherency [244.776278] Dynamic subtest coherency: SUCCESS (2.574s) [244.790702] Starting dynamic subtest: gtt [253.112489] Dynamic subtest gtt: SUCCESS (8.335s) [253.126965] Starting dynamic subtest: gem [255.182595] Dynamic subtest gem: SUCCESS (2.068s) [255.197118] Starting dynamic subtest: evict [257.097708] Dynamic subtest evict: SUCCESS (1.913s) [257.104399] Starting dynamic subtest: hugepages [264.904750] Dynamic subtest hugepages: SUCCESS (7.805s) [264.915614] Starting dynamic subtest: gem_contexts [277.423068] Dynamic subtest gem_contexts: SUCCESS (12.471s) [277.427955] Starting dynamic subtest: client [278.599039] Dynamic subtest client: SUCCESS (1.218s) [278.609280] Starting dynamic subtest: gem_migrate [279.767638] Dynamic subtest gem_migrate: SUCCESS (1.166s) [279.778420] Starting dynamic subtest: reset [283.969420] Dynamic subtest reset: SUCCESS (4.199s) [283.980171] Starting dynamic subtest: memory_region [285.209909] Dynamic subtest memory_region: SUCCESS (1.239s) [285.220713] Starting dynamic subtest: hangcheck [309.640322] Dynamic subtest hangcheck: SUCCESS (24.428s) [309.655463] Starting dynamic subtest: execlists [319.277123] Dynamic subtest execlists: SUCCESS (9.635s) [319.287612] Starting dynamic subtest: ring_submission [320.487655] Dynamic subtest ring_submission: SUCCESS (1.209s) [320.501884] Starting dynamic subtest: perf [321.770586] Dynamic subtest perf: SUCCESS (1.281s) [321.781238] Starting dynamic subtest: slpc [322.981871] Dynamic subtest slpc: SUCCESS (1.209s) [322.992230] Starting dynamic subtest: guc [324.189728] Dynamic subtest guc: SUCCESS (1.206s) [324.204168] Starting dynamic subtest: guc_multi_lrc [325.393300] Dynamic subtest guc_multi_lrc: SUCCESS (1.201s) [325.404458] Starting dynamic subtest: guc_hang [326.573613] Dynamic subtest guc_hang: SUCCESS (1.179s) [326.587504] Starting dynamic subtest: late_gt_pm [327.818672] Dynamic subtest late_gt_pm: SUCCESS (1.243s) [327.820201] Subtest live: SUCCESS (146.776s) [327.853271] [161/161] (675s left) dmabuf (all-tests) [327.899768] Starting subtest: all-tests [327.900839] Starting dynamic subtest: sanitycheck [328.017281] Dynamic subtest sanitycheck: SUCCESS (0.115s) [328.031661] Starting dynamic subtest: dma_fence [328.252367] Dynamic subtest dma_fence: SUCCESS (0.232s) [328.267216] Starting dynamic subtest: dma_fence_chain [337.302345] Dynamic subtest dma_fence_chain: SUCCESS (9.049s) [337.316122] Starting dynamic subtest: dma_fence_unwrap [337.404669] Dynamic subtest dma_fence_unwrap: SUCCESS (0.100s) [337.419527] Starting dynamic subtest: dma_resv [337.503559] Dynamic subtest dma_resv: SUCCESS (0.097s) [337.505550] Subtest all-tests: SUCCESS (9.602s) [337.541298] Closing watchdogs Done.