[42.026170] Initializing watchdogs [42.026301] /dev/watchdog0 [42.044933] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [42.052964] [001/162] (960s left) i915_module_load (load) [42.151810] Starting subtest: load [44.368736] Subtest load: SUCCESS (2.217s) [44.410432] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [44.411718] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [44.420673] [002/162] (958s left) core_auth (basic-auth) [45.872436] Starting subtest: basic-auth [45.880796] Subtest basic-auth: SUCCESS (0.002s) [45.999958] [003/162] (956s left) core_debugfs (read-all-entries) [46.065587] Starting subtest: read-all-entries [46.195072] Subtest read-all-entries: SUCCESS (0.131s) [46.284698] [004/162] (956s left) core_sysfs (read-all-entries) [46.354958] Starting subtest: read-all-entries [46.360568] Subtest read-all-entries: SUCCESS (0.003s) [46.479870] [005/162] (956s left) fbdev (eof) [46.536097] Starting subtest: eof [46.544226] Subtest eof: SUCCESS (0.000s) [46.600611] [006/162] (956s left) fbdev (info) [46.643995] Starting subtest: info [46.649794] Subtest info: SUCCESS (0.000s) [46.719899] [007/162] (956s left) fbdev (nullptr) [46.770795] Starting subtest: nullptr [46.776326] Subtest nullptr: SUCCESS (0.000s) [46.834235] [008/162] (956s left) fbdev (read) [46.885105] Starting subtest: read [47.821326] Subtest read: SUCCESS (0.927s) [47.886689] [009/162] (955s left) fbdev (write) [47.940301] Starting subtest: write [48.579729] Subtest write: SUCCESS (0.636s) [48.643851] [010/162] (954s left) gem_basic (bad-close) [48.703796] Starting subtest: bad-close [48.715015] Subtest bad-close: SUCCESS (0.000s) [48.824745] [011/162] (954s left) gem_basic (create-close) [48.894859] Starting subtest: create-close [48.906072] Subtest create-close: SUCCESS (0.000s) [49.016935] [012/162] (954s left) gem_basic (create-fd-close) [49.094869] Starting subtest: create-fd-close [49.106248] Subtest create-fd-close: SUCCESS (0.000s) [49.229943] [013/162] (953s left) gem_busy (busy@all-engines) [49.303077] Starting subtest: busy [49.308701] Starting dynamic subtest: all-engines [49.377299] Dynamic subtest all-engines: SUCCESS (0.074s) [49.383644] Subtest busy: SUCCESS (0.074s) [50.936976] [014/162] (952s left) gem_close_race (basic-process) [51.020108] Starting subtest: basic-process [51.081664] Subtest basic-process: SUCCESS (0.064s) [51.281230] [015/162] (951s left) gem_close_race (basic-threads) [51.363485] Starting subtest: basic-threads [52.734195] Subtest basic-threads: SUCCESS (1.380s) [52.928624] [016/162] (950s left) gem_ctx_create (basic) [53.002162] Starting subtest: basic [53.011052] Subtest basic: SUCCESS (0.000s) [53.195945] [017/162] (950s left) gem_ctx_create (basic-files) [53.268133] Starting subtest: basic-files [55.283436] Subtest basic-files: SUCCESS (2.021s) [56.957808] [018/162] (946s left) gem_ctx_exec (basic) [57.032987] Starting subtest: basic [57.038651] Subtest basic: SUCCESS (0.006s) [57.174520] [019/162] (946s left) gem_exec_basic (basic) [57.238460] Starting subtest: basic [57.244088] Starting dynamic subtest: rcs0-smem [57.249674] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [57.265039] Starting dynamic subtest: bcs0-smem [57.273360] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [57.283654] Starting dynamic subtest: vcs0-smem [57.289205] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [57.300057] Starting dynamic subtest: vcs1-smem [57.308358] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [57.320646] Starting dynamic subtest: vecs0-smem [57.326174] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [57.336063] Starting dynamic subtest: ccs0-smem [57.341555] Dynamic subtest ccs0-smem: SUCCESS (0.001s) [57.347360] Subtest basic: SUCCESS (0.011s) [58.934545] [020/162] (944s left) gem_exec_create (basic) [59.015542] Starting subtest: basic [59.021067] Starting dynamic subtest: smem [62.915222] Dynamic subtest smem: SUCCESS (3.908s) [62.924287] Subtest basic: SUCCESS (3.909s) [63.106021] [021/162] (940s left) gem_exec_fence (basic-busy) [63.285225] Starting subtest: basic-busy [63.293876] Starting dynamic subtest: rcs0 [63.366679] Dynamic subtest rcs0: SUCCESS (0.087s) [63.382244] Starting dynamic subtest: bcs0 [63.427439] Dynamic subtest bcs0: SUCCESS (0.059s) [63.440067] Starting dynamic subtest: vcs0 [63.485096] Dynamic subtest vcs0: SUCCESS (0.060s) [63.497963] Starting dynamic subtest: vcs1 [63.540079] Dynamic subtest vcs1: SUCCESS (0.055s) [63.552977] Starting dynamic subtest: vecs0 [63.599928] Dynamic subtest vecs0: SUCCESS (0.057s) [63.615763] Starting dynamic subtest: ccs0 [63.661292] Dynamic subtest ccs0: SUCCESS (0.064s) [63.666915] Subtest basic-busy: SUCCESS (0.382s) [65.943812] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [65.950172] [022/162] (937s left) gem_exec_fence (basic-wait) [66.139358] Starting subtest: basic-wait [66.147626] Starting dynamic subtest: rcs0 [66.197762] Dynamic subtest rcs0: SUCCESS (0.063s) [66.208624] Starting dynamic subtest: bcs0 [66.254723] Dynamic subtest bcs0: SUCCESS (0.054s) [66.266099] Starting dynamic subtest: vcs0 [66.316454] Dynamic subtest vcs0: SUCCESS (0.064s) [66.329077] Starting dynamic subtest: vcs1 [66.383535] Dynamic subtest vcs1: SUCCESS (0.065s) [66.395869] Starting dynamic subtest: vecs0 [66.446660] Dynamic subtest vecs0: SUCCESS (0.062s) [66.462500] Starting dynamic subtest: ccs0 [66.505470] Dynamic subtest ccs0: SUCCESS (0.058s) [66.511076] Subtest basic-wait: SUCCESS (0.368s) [68.008840] [023/162] (935s left) gem_exec_fence (basic-await) [68.184144] Starting subtest: basic-await [68.192469] Starting dynamic subtest: rcs0 [68.262415] Dynamic subtest rcs0: SUCCESS (0.083s) [68.276067] Starting dynamic subtest: bcs0 [68.340662] Dynamic subtest bcs0: SUCCESS (0.076s) [68.353823] Starting dynamic subtest: vcs0 [68.412030] Dynamic subtest vcs0: SUCCESS (0.073s) [68.425591] Starting dynamic subtest: vcs1 [68.492536] Dynamic subtest vcs1: SUCCESS (0.078s) [68.508993] Starting dynamic subtest: vecs0 [68.567962] Dynamic subtest vecs0: SUCCESS (0.075s) [68.585636] Starting dynamic subtest: ccs0 [68.643816] Dynamic subtest ccs0: SUCCESS (0.076s) [68.649508] Subtest basic-await: SUCCESS (0.462s) [69.989327] [024/162] (933s left) gem_exec_fence (nb-await) [70.187258] Starting subtest: nb-await [70.192743] Starting dynamic subtest: rcs0 [70.261570] Dynamic subtest rcs0: SUCCESS (0.078s) [70.273113] Starting dynamic subtest: bcs0 [70.316034] Dynamic subtest bcs0: SUCCESS (0.058s) [70.326851] Starting dynamic subtest: vcs0 [70.378230] Dynamic subtest vcs0: SUCCESS (0.059s) [70.389304] Starting dynamic subtest: vcs1 [70.437930] Dynamic subtest vcs1: SUCCESS (0.059s) [70.449224] Starting dynamic subtest: vecs0 [70.499283] Dynamic subtest vecs0: SUCCESS (0.061s) [70.515035] Starting dynamic subtest: ccs0 [70.559251] Dynamic subtest ccs0: SUCCESS (0.060s) [70.564946] Subtest nb-await: SUCCESS (0.377s) [72.072811] [025/162] (931s left) gem_exec_gttfill (basic) [72.163963] Starting subtest: basic [77.132727] Subtest basic: SUCCESS (4.965s) [77.332173] [026/162] (926s left) gem_exec_parallel (engines) [77.427460] Starting subtest: engines [77.433061] Starting dynamic subtest: basic [81.824370] Dynamic subtest basic: SUCCESS (4.393s) [81.837916] Starting dynamic subtest: contexts [86.213166] Dynamic subtest contexts: SUCCESS (4.386s) [86.225272] Starting dynamic subtest: fds [90.086082] Dynamic subtest fds: SUCCESS (3.875s) [90.099886] Starting dynamic subtest: userptr [91.906050] Dynamic subtest userptr: SUCCESS (1.819s) [91.913354] Subtest engines: SUCCESS (14.475s) [92.107873] [027/162] (911s left) gem_exec_store (basic) [92.198169] Starting subtest: basic [92.327389] Subtest basic: SUCCESS (0.142s) [92.532544] [028/162] (911s left) gem_flink_basic (bad-flink) [92.600743] Starting subtest: bad-flink [92.606397] Subtest bad-flink: SUCCESS (0.000s) [92.727192] [029/162] (911s left) gem_flink_basic (bad-open) [92.797202] Starting subtest: bad-open [92.803793] Subtest bad-open: SUCCESS (0.000s) [92.899402] [030/162] (910s left) gem_flink_basic (basic) [92.978373] Starting subtest: basic [92.984019] Subtest basic: SUCCESS (0.000s) [93.101047] [031/162] (910s left) gem_flink_basic (double-flink) [93.167649] Starting subtest: double-flink [93.173279] Subtest double-flink: SUCCESS (0.000s) [93.288880] [032/162] (910s left) gem_flink_basic (flink-lifetime) [93.355446] Starting subtest: flink-lifetime [93.361084] Subtest flink-lifetime: SUCCESS (0.002s) [93.493296] [033/162] (910s left) gem_huc_copy (huc-copy) [93.553967] Starting subtest: huc-copy [93.559601] Subtest huc-copy: SUCCESS (0.003s) [93.729364] [034/162] (910s left) gem_linear_blits (basic) [93.903044] Starting subtest: basic [93.915034] Subtest basic: SUCCESS (0.010s) [94.051814] [035/162] (910s left) gem_mmap (basic) [94.155521] Subtest basic: SKIP (0.000s) [94.228859] [036/162] (909s left) gem_mmap_gtt (basic) [94.303082] Subtest basic: SKIP (0.000s) [94.365708] [037/162] (909s left) gem_render_linear_blits (basic) [94.436653] Starting subtest: basic [94.473437] Subtest basic: SUCCESS (0.038s) [94.567109] [038/162] (909s left) gem_render_tiled_blits (basic) [94.637430] Subtest basic: SKIP (0.000s) [94.704837] [039/162] (909s left) gem_ringfill (basic-all) [100.873318] Starting subtest: basic-all [102.049818] Subtest basic-all: SUCCESS (1.181s) [102.224792] [040/162] (902s left) gem_softpin (allocator-basic) [102.295602] Starting subtest: allocator-basic [102.373091] Subtest allocator-basic: SUCCESS (0.079s) [102.557981] [041/162] (901s left) gem_softpin (allocator-basic-reserve) [102.637897] Starting subtest: allocator-basic-reserve [102.714725] Subtest allocator-basic-reserve: SUCCESS (0.082s) [102.892761] [042/162] (901s left) gem_softpin (safe-alignment) [102.965570] Starting subtest: safe-alignment [102.985168] Subtest safe-alignment: SUCCESS (0.023s) [104.949227] [043/162] (899s left) gem_sync (basic-all) [105.053101] Starting subtest: basic-all [108.141149] Subtest basic-all: SUCCESS (3.125s) [108.342679] [044/162] (896s left) gem_sync (basic-each) [108.449311] Starting subtest: basic-each [111.007147] Subtest basic-each: SUCCESS (2.595s) [111.205665] [045/162] (893s left) gem_tiled_blits (basic) [111.272839] Subtest basic: SKIP (0.000s) [111.337131] [046/162] (893s left) gem_tiled_fence_blits (basic) [111.413314] Subtest basic: SKIP (0.000s) [111.512248] [047/162] (893s left) gem_tiled_pread_basic [111.660257] [048/162] (893s left) gem_wait (busy@all-engines) [111.723041] Starting subtest: busy [111.730888] Starting dynamic subtest: all-engines [112.898704] Dynamic subtest all-engines: SUCCESS (1.171s) [112.907673] Subtest busy: SUCCESS (1.172s) [113.102587] [049/162] (891s left) gem_wait (wait@all-engines) [113.174645] Starting subtest: wait [113.180327] Starting dynamic subtest: all-engines [114.883079] Dynamic subtest all-engines: SUCCESS (1.700s) [114.892043] Subtest wait: SUCCESS (1.700s) [115.090851] [050/162] (889s left) i915_getparams_basic (basic-eu-total) [115.153841] Starting subtest: basic-eu-total [115.164490] Subtest basic-eu-total: SUCCESS (0.000s) [115.263114] [051/162] (889s left) i915_getparams_basic (basic-subslice-total) [115.324293] Starting subtest: basic-subslice-total [115.335487] Subtest basic-subslice-total: SUCCESS (0.000s) [115.431790] [052/162] (889s left) i915_hangman (error-state-basic) [115.517037] Starting subtest: error-state-basic [115.647965] Subtest error-state-basic: SUCCESS (0.125s) [115.738768] [053/162] (889s left) i915_pciid [115.905676] [054/162] (889s left) intel_hwmon (hwmon-read) [115.970088] Subtest hwmon-read: SKIP (0.000s) [116.054421] [055/162] (889s left) intel_hwmon (hwmon-write) [116.118793] Subtest hwmon-write: SKIP (0.000s) [116.189397] [056/162] (888s left) kms_addfb_basic (addfb25-4-tiled) [116.295673] Starting subtest: addfb25-4-tiled [116.301264] Subtest addfb25-4-tiled: SUCCESS (0.000s) [116.403674] [057/162] (888s left) kms_addfb_basic (addfb25-bad-modifier) [116.489851] Starting subtest: addfb25-bad-modifier [116.498415] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [116.609354] [058/162] (888s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [116.703437] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [116.838097] [059/162] (888s left) kms_addfb_basic (addfb25-modifier-no-flag) [116.936285] Starting subtest: addfb25-modifier-no-flag [116.945184] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [117.058790] [060/162] (888s left) kms_addfb_basic (addfb25-x-tiled-legacy) [117.164410] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [117.270671] [061/162] (888s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [117.367609] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [117.482048] [062/162] (887s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [117.578295] Starting subtest: addfb25-yf-tiled-legacy [117.584057] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [117.701203] [063/162] (887s left) kms_addfb_basic (addfb25-y-tiled-legacy) [117.796715] Starting subtest: addfb25-y-tiled-legacy [117.802526] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [117.920839] [064/162] (887s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [118.013047] Starting subtest: addfb25-y-tiled-small-legacy [118.024049] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [118.134695] [065/162] (887s left) kms_addfb_basic (bad-pitch-0) [118.193187] Starting subtest: bad-pitch-0 [118.198777] Subtest bad-pitch-0: SUCCESS (0.000s) [118.352987] [066/162] (887s left) kms_addfb_basic (bad-pitch-1024) [118.423394] Starting subtest: bad-pitch-1024 [118.429145] Subtest bad-pitch-1024: SUCCESS (0.000s) [118.555408] [067/162] (887s left) kms_addfb_basic (bad-pitch-128) [118.623291] Starting subtest: bad-pitch-128 [118.628885] Subtest bad-pitch-128: SUCCESS (0.000s) [118.772562] [068/162] (886s left) kms_addfb_basic (bad-pitch-256) [118.829691] Starting subtest: bad-pitch-256 [118.835366] Subtest bad-pitch-256: SUCCESS (0.000s) [118.964300] [069/162] (886s left) kms_addfb_basic (bad-pitch-32) [119.025846] Starting subtest: bad-pitch-32 [119.031489] Subtest bad-pitch-32: SUCCESS (0.000s) [119.157761] [070/162] (886s left) kms_addfb_basic (bad-pitch-63) [119.213312] Starting subtest: bad-pitch-63 [119.218979] Subtest bad-pitch-63: SUCCESS (0.000s) [119.372844] [071/162] (886s left) kms_addfb_basic (bad-pitch-65536) [119.441270] Starting subtest: bad-pitch-65536 [119.446858] Subtest bad-pitch-65536: SUCCESS (0.000s) [119.580664] [072/162] (886s left) kms_addfb_basic (bad-pitch-999) [119.661785] Starting subtest: bad-pitch-999 [119.670885] Subtest bad-pitch-999: SUCCESS (0.000s) [119.804154] [073/162] (886s left) kms_addfb_basic (basic) [119.878319] Starting subtest: basic [119.886892] Subtest basic: SUCCESS (0.000s) [120.037593] [074/162] (885s left) kms_addfb_basic (basic-x-tiled-legacy) [120.111303] Starting subtest: basic-x-tiled-legacy [120.125241] Subtest basic-x-tiled-legacy: SKIP (0.000s) [120.261438] [075/162] (885s left) kms_addfb_basic (basic-y-tiled-legacy) [120.324762] Starting subtest: basic-y-tiled-legacy [120.335860] Subtest basic-y-tiled-legacy: SKIP (0.000s) [120.470864] [076/162] (885s left) kms_addfb_basic (bo-too-small) [120.590767] Starting subtest: bo-too-small [120.598317] Subtest bo-too-small: SUCCESS (0.000s) [120.709631] [077/162] (885s left) kms_addfb_basic (bo-too-small-due-to-tiling) [120.808157] Starting subtest: bo-too-small-due-to-tiling [120.821505] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [120.933185] [078/162] (885s left) kms_addfb_basic (clobberred-modifier) [120.994584] Starting subtest: clobberred-modifier [121.007898] Subtest clobberred-modifier: SKIP (0.000s) [121.147109] [079/162] (885s left) kms_addfb_basic (framebuffer-vs-set-tiling) [121.212845] Starting subtest: framebuffer-vs-set-tiling [121.227673] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [121.369928] [080/162] (884s left) kms_addfb_basic (invalid-get-prop) [121.439211] Starting subtest: invalid-get-prop [121.444625] Subtest invalid-get-prop: SUCCESS (0.000s) [121.594825] [081/162] (884s left) kms_addfb_basic (invalid-get-prop-any) [121.661248] Starting subtest: invalid-get-prop-any [121.666933] Subtest invalid-get-prop-any: SUCCESS (0.000s) [121.807899] [082/162] (884s left) kms_addfb_basic (invalid-set-prop) [121.880920] Starting subtest: invalid-set-prop [121.886725] Subtest invalid-set-prop: SUCCESS (0.000s) [122.016435] [083/162] (884s left) kms_addfb_basic (invalid-set-prop-any) [122.102301] Starting subtest: invalid-set-prop-any [122.111377] Subtest invalid-set-prop-any: SUCCESS (0.000s) [122.256624] [084/162] (884s left) kms_addfb_basic (no-handle) [122.334694] Starting subtest: no-handle [122.340459] Subtest no-handle: SUCCESS (0.000s) [122.476170] [085/162] (884s left) kms_addfb_basic (size-max) [122.576090] Starting subtest: size-max [122.581498] Subtest size-max: SUCCESS (0.000s) [122.695662] [086/162] (883s left) kms_addfb_basic (small-bo) [122.789462] Starting subtest: small-bo [122.795051] Subtest small-bo: SUCCESS (0.000s) [122.912347] [087/162] (883s left) kms_addfb_basic (tile-pitch-mismatch) [122.974363] Starting subtest: tile-pitch-mismatch [122.985588] Subtest tile-pitch-mismatch: SKIP (0.000s) [123.135324] [088/162] (883s left) kms_addfb_basic (too-high) [123.231758] Starting subtest: too-high [123.237321] Subtest too-high: SUCCESS (0.000s) [123.363668] [089/162] (883s left) kms_addfb_basic (too-wide) [123.459730] Starting subtest: too-wide [123.465414] Subtest too-wide: SUCCESS (0.000s) [123.564335] [090/162] (883s left) kms_addfb_basic (unused-handle) [123.629103] Starting subtest: unused-handle [123.634644] Subtest unused-handle: SUCCESS (0.000s) [123.782954] [091/162] (882s left) kms_addfb_basic (unused-modifier) [123.847947] Starting subtest: unused-modifier [123.853609] Subtest unused-modifier: SUCCESS (0.000s) [123.978100] [092/162] (882s left) kms_addfb_basic (unused-offsets) [124.049454] Starting subtest: unused-offsets [124.055023] Subtest unused-offsets: SUCCESS (0.000s) [124.198199] [093/162] (882s left) kms_addfb_basic (unused-pitches) [124.257095] Starting subtest: unused-pitches [124.262567] Subtest unused-pitches: SUCCESS (0.000s) [124.422862] [094/162] (882s left) kms_busy (basic) [124.547117] Starting subtest: basic [124.552797] Starting dynamic subtest: flip [125.322837] Dynamic subtest flip: SUCCESS (0.783s) [125.337818] Starting dynamic subtest: modeset [128.751862] Dynamic subtest modeset: SUCCESS (3.423s) [128.758024] Subtest basic: SUCCESS (4.208s) [129.556237] [095/162] (877s left) kms_prop_blob (basic) [129.621403] Starting subtest: basic [129.626790] Subtest basic: SUCCESS (0.000s) [129.742236] [096/162] (877s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [129.876850] Starting subtest: basic-busy-flip-before-cursor-atomic [129.890721] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [130.013850] [097/162] (877s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [130.136314] Starting subtest: basic-busy-flip-before-cursor-legacy [130.147572] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [130.286552] [098/162] (876s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [130.417310] Starting subtest: basic-flip-after-cursor-atomic [131.676634] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.261s) [132.488308] [099/162] (874s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [132.626127] Starting subtest: basic-flip-after-cursor-legacy [133.886319] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.258s) [134.718913] [100/162] (872s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [134.858600] Starting subtest: basic-flip-after-cursor-varying-size [136.134632] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.275s) [136.951053] [101/162] (870s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [137.082452] Starting subtest: basic-flip-before-cursor-atomic [138.326810] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.241s) [139.189715] [102/162] (868s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [139.317451] Starting subtest: basic-flip-before-cursor-legacy [140.567160] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.243s) [141.411808] [103/162] (865s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [141.546563] Starting subtest: basic-flip-before-cursor-varying-size [142.816012] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.275s) [143.639826] [104/162] (863s left) kms_dsc (dsc-basic) [143.738649] Starting subtest: dsc-basic [143.771851] Subtest dsc-basic: SKIP (0.000s) [143.848901] [105/162] (863s left) kms_flip (basic-flip-vs-dpms) [143.960932] Starting subtest: basic-flip-vs-dpms [143.966451] Starting dynamic subtest: A-eDP1 [146.614852] Dynamic subtest A-eDP1: SUCCESS (2.660s) [146.629333] Starting dynamic subtest: B-eDP1 [148.777580] Dynamic subtest B-eDP1: SUCCESS (2.159s) [148.791086] Starting dynamic subtest: C-eDP1 [150.930742] Dynamic subtest C-eDP1: SUCCESS (2.154s) [150.942633] Starting dynamic subtest: D-eDP1 [153.085073] Dynamic subtest D-eDP1: SUCCESS (2.151s) [153.090662] Subtest basic-flip-vs-dpms: SUCCESS (9.130s) [153.887059] [106/162] (853s left) kms_flip (basic-flip-vs-modeset) [153.986492] Starting subtest: basic-flip-vs-modeset [153.991964] Starting dynamic subtest: A-eDP1 [156.662203] Dynamic subtest A-eDP1: SUCCESS (2.678s) [156.673881] Starting dynamic subtest: B-eDP1 [158.825655] Dynamic subtest B-eDP1: SUCCESS (2.155s) [158.839964] Starting dynamic subtest: C-eDP1 [160.970314] Dynamic subtest C-eDP1: SUCCESS (2.149s) [160.984183] Starting dynamic subtest: D-eDP1 [163.128058] Dynamic subtest D-eDP1: SUCCESS (2.154s) [163.133658] Subtest basic-flip-vs-modeset: SUCCESS (9.144s) [163.927184] [107/162] (843s left) kms_flip (basic-flip-vs-wf_vblank) [164.042727] Starting subtest: basic-flip-vs-wf_vblank [164.048444] Starting dynamic subtest: A-eDP1 [166.113546] Dynamic subtest A-eDP1: SUCCESS (2.079s) [166.126109] Starting dynamic subtest: B-eDP1 [168.142384] Dynamic subtest B-eDP1: SUCCESS (2.028s) [168.156241] Starting dynamic subtest: C-eDP1 [170.162973] Dynamic subtest C-eDP1: SUCCESS (2.013s) [170.175662] Starting dynamic subtest: D-eDP1 [172.185959] Dynamic subtest D-eDP1: SUCCESS (2.021s) [172.191773] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.152s) [173.369585] [108/162] (834s left) kms_flip (basic-plain-flip) [173.482951] Starting subtest: basic-plain-flip [173.491424] Starting dynamic subtest: A-eDP1 [175.272665] Dynamic subtest A-eDP1: SUCCESS (1.803s) [175.286307] Starting dynamic subtest: B-eDP1 [177.001179] Dynamic subtest B-eDP1: SUCCESS (1.726s) [177.015604] Starting dynamic subtest: C-eDP1 [178.714567] Dynamic subtest C-eDP1: SUCCESS (1.708s) [178.729073] Starting dynamic subtest: D-eDP1 [180.446250] Dynamic subtest D-eDP1: SUCCESS (1.729s) [180.452029] Subtest basic-plain-flip: SUCCESS (6.977s) [181.609081] [109/162] (825s left) kms_force_connector_basic (force-connector-state) [181.694063] Starting subtest: force-connector-state [182.276358] Subtest force-connector-state: SUCCESS (0.584s) [183.243503] [110/162] (824s left) kms_force_connector_basic (force-edid) [183.335945] Starting subtest: force-edid [183.589938] Subtest force-edid: SUCCESS (0.259s) [183.727286] [111/162] (823s left) kms_force_connector_basic (force-load-detect) [183.814940] Starting subtest: force-load-detect [183.825976] Subtest force-load-detect: SKIP (0.000s) [183.938597] [112/162] (823s left) kms_force_connector_basic (prune-stale-modes) [184.041720] Starting subtest: prune-stale-modes [184.355537] Subtest prune-stale-modes: SUCCESS (0.318s) [184.492968] [113/162] (823s left) kms_frontbuffer_tracking (basic) [184.613048] Starting subtest: basic [188.930449] Subtest basic: SUCCESS (4.334s) [189.085116] [114/162] (818s left) kms_hdmi_inject (inject-audio) [189.433752] Starting subtest: inject-audio [189.674837] Subtest inject-audio: SUCCESS (0.243s) [190.281101] [115/162] (817s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [190.373063] Starting subtest: compare-crc-sanitycheck-xr24 [190.378743] Starting dynamic subtest: pipe-A-eDP-1 [191.193069] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.823s) [191.205123] Starting dynamic subtest: pipe-B-eDP-1 [192.516951] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.317s) [192.528788] Starting dynamic subtest: pipe-C-eDP-1 [193.782926] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.265s) [193.796541] Starting dynamic subtest: pipe-D-eDP-1 [195.078119] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.298s) [195.083889] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.708s) [195.938927] [116/162] (811s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [196.035319] Starting subtest: compare-crc-sanitycheck-nv12 [196.040932] Starting dynamic subtest: pipe-A-eDP-1 [196.896659] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.858s) [196.908983] Starting dynamic subtest: pipe-B-eDP-1 [198.199210] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.302s) [198.211354] Starting dynamic subtest: pipe-C-eDP-1 [199.482440] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.283s) [199.496951] Starting dynamic subtest: pipe-D-eDP-1 [200.781756] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.295s) [200.787376] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.744s) [201.639821] [117/162] (806s left) kms_pipe_crc_basic (hang-read-crc) [201.743263] Starting subtest: hang-read-crc [201.749049] Starting dynamic subtest: pipe-A-eDP-1 [204.170625] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.423s) [204.184310] Starting dynamic subtest: pipe-B-eDP-1 [207.150304] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.980s) [207.166259] Starting dynamic subtest: pipe-C-eDP-1 [210.127978] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.983s) [210.141750] Starting dynamic subtest: pipe-D-eDP-1 [212.933242] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.799s) [212.938840] Subtest hang-read-crc: SUCCESS (11.189s) [213.734934] [118/162] (794s left) kms_pipe_crc_basic (nonblocking-crc) [213.828250] Starting subtest: nonblocking-crc [213.833858] Starting dynamic subtest: pipe-A-eDP-1 [214.770304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.940s) [214.782595] Starting dynamic subtest: pipe-B-eDP-1 [216.368830] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.591s) [216.382535] Starting dynamic subtest: pipe-C-eDP-1 [217.913021] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.543s) [217.930620] Starting dynamic subtest: pipe-D-eDP-1 [219.380424] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.467s) [219.385908] Subtest nonblocking-crc: SUCCESS (5.547s) [220.241046] [119/162] (787s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [220.333550] Starting subtest: nonblocking-crc-frame-sequence [220.339040] Starting dynamic subtest: pipe-A-eDP-1 [221.290843] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.958s) [221.304725] Starting dynamic subtest: pipe-B-eDP-1 [222.847313] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.548s) [222.859580] Starting dynamic subtest: pipe-C-eDP-1 [224.395022] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.551s) [224.409250] Starting dynamic subtest: pipe-D-eDP-1 [225.876105] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.481s) [225.884702] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.544s) [226.751057] [120/162] (781s left) kms_pipe_crc_basic (read-crc) [226.855283] Starting subtest: read-crc [226.860999] Starting dynamic subtest: pipe-A-eDP-1 [227.731243] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.877s) [227.744889] Starting dynamic subtest: pipe-B-eDP-1 [229.177903] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.445s) [229.195863] Starting dynamic subtest: pipe-C-eDP-1 [230.629247] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.445s) [230.641173] Starting dynamic subtest: pipe-D-eDP-1 [232.026261] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.399s) [232.031930] Subtest read-crc: SUCCESS (5.172s) [232.832861] [121/162] (775s left) kms_pipe_crc_basic (read-crc-frame-sequence) [232.924397] Starting subtest: read-crc-frame-sequence [232.929889] Starting dynamic subtest: pipe-A-eDP-1 [233.828933] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.895s) [233.841691] Starting dynamic subtest: pipe-B-eDP-1 [235.260399] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s) [235.273865] Starting dynamic subtest: pipe-C-eDP-1 [236.746107] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.483s) [236.758326] Starting dynamic subtest: pipe-D-eDP-1 [238.223877] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.482s) [238.229457] Subtest read-crc-frame-sequence: SUCCESS (5.302s) [239.040860] [122/162] (769s left) kms_pm_backlight (basic-brightness) [239.143024] Starting subtest: basic-brightness [239.236856] Starting dynamic subtest: eDP-1 [239.545095] Dynamic subtest eDP-1: SUCCESS (0.313s) [239.551274] Subtest basic-brightness: SUCCESS (0.411s) [240.439866] [123/162] (767s left) kms_pm_rpm (basic-pci-d3-state) [242.000858] Starting subtest: basic-pci-d3-state [243.463312] Subtest basic-pci-d3-state: SUCCESS (1.460s) [243.563511] [124/162] (764s left) kms_pm_rpm (basic-rte) [243.609448] Starting subtest: basic-rte [246.593704] Subtest basic-rte: SUCCESS (2.992s) [248.372079] [125/162] (759s left) kms_psr (psr-primary-page-flip) [248.459503] Starting subtest: psr-primary-page-flip [248.465146] Starting dynamic subtest: eDP-1 [250.430049] Dynamic subtest eDP-1: SUCCESS (1.971s) [250.435810] Subtest psr-primary-page-flip: SUCCESS (1.972s) [251.233135] [126/162] (757s left) kms_psr (psr-cursor-plane-move) [251.334169] Starting subtest: psr-cursor-plane-move [251.339920] Starting dynamic subtest: eDP-1 [253.217489] Dynamic subtest eDP-1: SUCCESS (1.882s) [253.223230] Subtest psr-cursor-plane-move: SUCCESS (1.883s) [254.034474] [127/162] (754s left) kms_psr (psr-sprite-plane-onoff) [254.140780] Starting subtest: psr-sprite-plane-onoff [254.146470] Starting dynamic subtest: eDP-1 [256.174084] Dynamic subtest eDP-1: SUCCESS (2.039s) [256.182366] Subtest psr-sprite-plane-onoff: SUCCESS (2.040s) [257.037917] [128/162] (751s left) kms_psr (psr-primary-mmap-gtt) [257.133868] Starting subtest: psr-primary-mmap-gtt [257.143245] Starting dynamic subtest: eDP-1 [258.832970] Dynamic subtest eDP-1: SKIP (1.685s) [258.847080] Subtest psr-primary-mmap-gtt: SKIP (1.686s) [258.986785] [129/162] (749s left) kms_setmode (basic-clone-single-crtc) [259.044202] Starting subtest: basic-clone-single-crtc [259.061940] Subtest basic-clone-single-crtc: SKIP (0.000s) [259.156865] [130/162] (749s left) i915_pm_rps (basic-api) [259.225266] Starting subtest: basic-api [259.239464] Subtest basic-api: SKIP (0.001s) [259.384578] [131/162] (749s left) prime_self_import (basic-llseek-bad) [259.429365] Starting subtest: basic-llseek-bad [259.440360] Subtest basic-llseek-bad: SUCCESS (0.013s) [259.564389] [132/162] (749s left) prime_self_import (basic-llseek-size) [259.613677] Starting subtest: basic-llseek-size [259.633157] Subtest basic-llseek-size: SUCCESS (0.022s) [259.765478] [133/162] (748s left) prime_self_import (basic-with_fd_dup) [259.809707] Starting subtest: basic-with_fd_dup [259.834744] Subtest basic-with_fd_dup: SUCCESS (0.026s) [259.968345] [134/162] (748s left) prime_self_import (basic-with_one_bo) [260.016062] Starting subtest: basic-with_one_bo [260.033834] Subtest basic-with_one_bo: SUCCESS (0.020s) [260.160978] [135/162] (748s left) prime_self_import (basic-with_one_bo_two_files) [260.224165] Starting subtest: basic-with_one_bo_two_files [260.235533] Subtest basic-with_one_bo_two_files: SUCCESS (0.027s) [260.363403] [136/162] (748s left) prime_self_import (basic-with_two_bos) [260.413472] Starting subtest: basic-with_two_bos [260.426660] Subtest basic-with_two_bos: SUCCESS (0.020s) [260.554602] [137/162] (748s left) prime_vgem (basic-fence-flip) [260.628623] Starting subtest: basic-fence-flip [261.053826] Subtest basic-fence-flip: SUCCESS (0.427s) [261.184953] [138/162] (747s left) prime_vgem (basic-fence-mmap) [261.266077] Starting subtest: basic-fence-mmap [261.277167] Subtest basic-fence-mmap: SKIP (0.000s) [261.377439] [139/162] (747s left) prime_vgem (basic-fence-read) [261.450121] Starting subtest: basic-fence-read [261.461392] Subtest basic-fence-read: SKIP (0.006s) [261.580675] [140/162] (747s left) prime_vgem (basic-gtt) [261.660228] Starting subtest: basic-gtt [261.671502] Subtest basic-gtt: SKIP (0.000s) [261.778495] [141/162] (747s left) prime_vgem (basic-read) [261.863318] Starting subtest: basic-read [261.874311] Subtest basic-read: SKIP (0.004s) [261.996121] [142/162] (747s left) prime_vgem (basic-write) [262.076857] Starting subtest: basic-write [262.088299] Subtest basic-write: SKIP (0.004s) [262.195298] [143/162] (746s left) vgem_basic (setversion) [262.250652] Starting subtest: setversion [262.261633] Subtest setversion: SUCCESS (0.000s) [262.311254] [144/162] (746s left) vgem_basic (create) [262.365747] Starting subtest: create [262.371314] Subtest create: SUCCESS (0.000s) [262.429487] [145/162] (746s left) vgem_basic (debugfs) [262.477453] Starting subtest: debugfs [262.483120] Subtest debugfs: SUCCESS (0.000s) [262.545898] [146/162] (746s left) vgem_basic (dmabuf-export) [262.594420] Starting subtest: dmabuf-export [262.632170] Subtest dmabuf-export: SUCCESS (0.041s) [262.763232] [147/162] (746s left) vgem_basic (dmabuf-fence) [262.816184] Starting subtest: dmabuf-fence [262.821825] Subtest dmabuf-fence: SUCCESS (0.000s) [262.876237] [148/162] (746s left) vgem_basic (dmabuf-fence-before) [262.943391] Starting subtest: dmabuf-fence-before [262.952606] Subtest dmabuf-fence-before: SUCCESS (0.001s) [263.016348] [149/162] (746s left) vgem_basic (dmabuf-mmap) [263.085202] Starting subtest: dmabuf-mmap [263.092594] Subtest dmabuf-mmap: SUCCESS (0.007s) [263.143133] [150/162] (746s left) vgem_basic (mmap) [263.209809] Starting subtest: mmap [263.215380] Subtest mmap: SUCCESS (0.006s) [263.283416] [151/162] (746s left) vgem_basic (second-client) [263.342897] Starting subtest: second-client [263.378800] Subtest second-client: SUCCESS (0.033s) [263.446209] [152/162] (746s left) vgem_basic (sysfs) [263.509778] Starting subtest: sysfs [263.515265] Subtest sysfs: SUCCESS (0.001s) [263.583232] [153/162] (746s left) core_hotunplug (unbind-rebind) [263.699785] Starting subtest: unbind-rebind [269.955189] Subtest unbind-rebind: SUCCESS (6.260s) [270.009992] [154/162] (739s left) vgem_basic (unload) [270.053356] Starting subtest: unload [299.242535] Subtest unload: SUCCESS (29.184s) [299.350166] [155/162] (710s left) i915_module_load (reload) [299.392560] Starting subtest: reload [302.890659] Subtest reload: SUCCESS (3.502s) [302.946813] [156/162] (706s left) gem_lmem_swapping (basic) [303.008387] Subtest basic: SKIP (0.000s) [303.060120] [157/162] (706s left) gem_lmem_swapping (parallel-random-engines) [303.127337] Subtest parallel-random-engines: SKIP (0.000s) [303.179033] [158/162] (706s left) gem_lmem_swapping (random-engines) [303.241365] Subtest random-engines: SKIP (0.000s) [303.291447] [159/162] (706s left) gem_lmem_swapping (verify-random) [303.347836] Subtest verify-random: SKIP (0.000s) [303.407171] [160/162] (706s left) i915_pm_rpm (module-reload) [305.680707] Starting subtest: module-reload [321.196315] Subtest module-reload: SUCCESS (15.506s) [321.228348] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [321.229074] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [321.235289] [161/162] (688s left) i915_selftest (live)