[39.445871] Initializing watchdogs [39.445950] /dev/watchdog0 [39.466350] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:46d3 Intel Alderlake_n (Gen12) [39.471204] [001/162] (960s left) i915_module_load (load) [39.514227] Starting subtest: load [42.059137] Subtest load: SUCCESS (2.544s) [42.100554] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [42.102172] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [42.104661] [002/162] (957s left) core_auth (basic-auth) [42.194223] Starting subtest: basic-auth [42.196347] Subtest basic-auth: SUCCESS (0.002s) [42.316879] [003/162] (957s left) core_debugfs (read-all-entries) [42.354726] Starting subtest: read-all-entries [42.485258] Subtest read-all-entries: SUCCESS (0.131s) [42.600517] [004/162] (957s left) core_sysfs (read-all-entries) [42.638342] Starting subtest: read-all-entries [42.642858] Subtest read-all-entries: SUCCESS (0.004s) [42.730663] [005/162] (957s left) fbdev (eof) [42.782766] Starting subtest: eof [42.783589] Subtest eof: SUCCESS (0.000s) [42.879767] [006/162] (957s left) fbdev (info) [42.915806] Starting subtest: info [42.916566] Subtest info: SUCCESS (0.000s) [43.013683] [007/162] (957s left) fbdev (nullptr) [43.064774] Starting subtest: nullptr [43.065916] Subtest nullptr: SUCCESS (0.000s) [43.180520] [008/162] (957s left) fbdev (read) [43.231484] Starting subtest: read [50.011897] Subtest read: SUCCESS (6.770s) [50.092675] [009/162] (950s left) fbdev (write) [50.132487] Starting subtest: write [53.592211] Subtest write: SUCCESS (3.426s) [53.685642] [010/162] (946s left) gem_basic (bad-close) [53.723281] Starting subtest: bad-close [53.724743] Subtest bad-close: SUCCESS (0.000s) [53.819346] [011/162] (946s left) gem_basic (create-close) [53.857977] Starting subtest: create-close [53.859391] Subtest create-close: SUCCESS (0.000s) [53.988692] [012/162] (946s left) gem_basic (create-fd-close) [54.026675] Starting subtest: create-fd-close [54.028088] Subtest create-fd-close: SUCCESS (0.000s) [54.136740] [013/162] (946s left) gem_busy (busy@all-engines) [54.188839] Starting subtest: busy [54.189616] Starting dynamic subtest: all-engines [54.219800] Dynamic subtest all-engines: SUCCESS (0.031s) [54.220661] Subtest busy: SUCCESS (0.031s) [54.597425] [014/162] (945s left) gem_close_race (basic-process) [54.646385] Starting subtest: basic-process [54.679540] Subtest basic-process: SUCCESS (0.033s) [54.893474] [015/162] (945s left) gem_close_race (basic-threads) [54.943782] Starting subtest: basic-threads [56.083515] Subtest basic-threads: SUCCESS (1.140s) [56.330070] [016/162] (944s left) gem_ctx_create (basic) [56.420646] Starting subtest: basic [56.421720] Subtest basic: SUCCESS (0.000s) [56.655616] [017/162] (944s left) gem_ctx_create (basic-files) [56.728995] Starting subtest: basic-files [58.746493] Subtest basic-files: SUCCESS (2.018s) [59.101694] [018/162] (941s left) gem_ctx_exec (basic) [59.164436] Starting subtest: basic [59.165244] Subtest basic: SUCCESS (0.004s) [59.307679] [019/162] (941s left) gem_exec_basic (basic) [59.366413] Starting subtest: basic [59.367306] Starting dynamic subtest: rcs0-smem [59.369038] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [59.381436] Starting dynamic subtest: bcs0-smem [59.382314] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [59.392774] Starting dynamic subtest: vcs0-smem [59.393589] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [59.403755] Starting dynamic subtest: vecs0-smem [59.404643] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [59.405431] Subtest basic: SUCCESS (0.006s) [59.630909] [020/162] (941s left) gem_exec_create (basic) [59.689252] Starting subtest: basic [59.690039] Starting dynamic subtest: smem [61.792130] Dynamic subtest smem: SUCCESS (2.101s) [61.793413] Subtest basic: SUCCESS (2.102s) [62.016718] [021/162] (938s left) gem_exec_fence (basic-busy) [62.192104] Starting subtest: basic-busy [62.193084] Starting dynamic subtest: rcs0 [62.251164] Dynamic subtest rcs0: SUCCESS (0.060s) [62.267300] Starting dynamic subtest: bcs0 [62.299329] Dynamic subtest bcs0: SUCCESS (0.047s) [62.317386] Starting dynamic subtest: vcs0 [62.348524] Dynamic subtest vcs0: SUCCESS (0.048s) [62.366937] Starting dynamic subtest: vecs0 [62.397482] Dynamic subtest vecs0: SUCCESS (0.048s) [62.398791] Subtest basic-busy: SUCCESS (0.207s) [62.973741] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [62.976657] [022/162] (937s left) gem_exec_fence (basic-wait) [63.142319] Starting subtest: basic-wait [63.143408] Starting dynamic subtest: rcs0 [63.201523] Dynamic subtest rcs0: SUCCESS (0.061s) [63.218178] Starting dynamic subtest: bcs0 [63.259520] Dynamic subtest bcs0: SUCCESS (0.057s) [63.275490] Starting dynamic subtest: vcs0 [63.309523] Dynamic subtest vcs0: SUCCESS (0.049s) [63.325276] Starting dynamic subtest: vecs0 [63.361550] Dynamic subtest vecs0: SUCCESS (0.050s) [63.362733] Subtest basic-wait: SUCCESS (0.222s) [63.885884] [023/162] (937s left) gem_exec_fence (basic-await) [64.051454] Starting subtest: basic-await [64.052972] Starting dynamic subtest: rcs0 [64.133478] Dynamic subtest rcs0: SUCCESS (0.084s) [64.150065] Starting dynamic subtest: bcs0 [64.219831] Dynamic subtest bcs0: SUCCESS (0.085s) [64.239194] Starting dynamic subtest: vcs0 [64.307820] Dynamic subtest vcs0: SUCCESS (0.087s) [64.326777] Starting dynamic subtest: vecs0 [64.396285] Dynamic subtest vecs0: SUCCESS (0.087s) [64.397729] Subtest basic-await: SUCCESS (0.348s) [64.931164] [024/162] (936s left) gem_exec_fence (nb-await) [65.096453] Starting subtest: nb-await [65.097504] Starting dynamic subtest: rcs0 [65.161310] Dynamic subtest rcs0: SUCCESS (0.066s) [65.181589] Starting dynamic subtest: bcs0 [65.226268] Dynamic subtest bcs0: SUCCESS (0.064s) [65.247175] Starting dynamic subtest: vcs0 [65.293479] Dynamic subtest vcs0: SUCCESS (0.065s) [65.304508] Starting dynamic subtest: vecs0 [65.355471] Dynamic subtest vecs0: SUCCESS (0.060s) [65.357040] Subtest nb-await: SUCCESS (0.260s) [65.884354] [025/162] (935s left) gem_exec_gttfill (basic) [65.932982] Starting subtest: basic [69.943835] Subtest basic: SUCCESS (4.002s) [70.180596] [026/162] (930s left) gem_exec_parallel (engines) [70.308585] Starting subtest: engines [70.309577] Starting dynamic subtest: basic [72.682380] Dynamic subtest basic: SUCCESS (2.373s) [72.701189] Starting dynamic subtest: contexts [76.772643] Dynamic subtest contexts: SUCCESS (4.081s) [76.790500] Starting dynamic subtest: fds [82.088673] Dynamic subtest fds: SUCCESS (5.315s) [82.108418] Starting dynamic subtest: userptr [84.418457] Dynamic subtest userptr: SUCCESS (2.338s) [84.419742] Subtest engines: SUCCESS (14.110s) [84.660841] [027/162] (916s left) gem_exec_store (basic) [84.727781] Starting subtest: basic [84.799581] Subtest basic: SUCCESS (0.071s) [85.062409] [028/162] (916s left) gem_flink_basic (bad-flink) [85.107719] Starting subtest: bad-flink [85.108548] Subtest bad-flink: SUCCESS (0.000s) [85.210880] [029/162] (916s left) gem_flink_basic (bad-open) [85.254885] Starting subtest: bad-open [85.255630] Subtest bad-open: SUCCESS (0.000s) [85.356862] [030/162] (916s left) gem_flink_basic (basic) [85.400599] Starting subtest: basic [85.401383] Subtest basic: SUCCESS (0.000s) [85.541220] [031/162] (915s left) gem_flink_basic (double-flink) [85.585783] Starting subtest: double-flink [85.586550] Subtest double-flink: SUCCESS (0.000s) [85.704806] [032/162] (915s left) gem_flink_basic (flink-lifetime) [85.749051] Starting subtest: flink-lifetime [85.750646] Subtest flink-lifetime: SUCCESS (0.002s) [85.894500] [033/162] (915s left) gem_huc_copy (huc-copy) [85.944249] Starting subtest: huc-copy [85.947891] Subtest huc-copy: SUCCESS (0.004s) [86.091021] [034/162] (915s left) gem_linear_blits (basic) [86.245447] Starting subtest: basic [86.254862] Subtest basic: SUCCESS (0.010s) [86.430516] [035/162] (915s left) gem_mmap (basic) [86.520209] Starting subtest: basic [86.523776] Subtest basic: SUCCESS (0.001s) [86.656068] [036/162] (915s left) gem_mmap_gtt (basic) [86.699103] Starting subtest: basic [86.699851] Subtest basic: SUCCESS (0.001s) [86.827344] [037/162] (914s left) gem_render_linear_blits (basic) [86.878909] Starting subtest: basic [86.922604] Subtest basic: SUCCESS (0.044s) [87.023912] [038/162] (914s left) gem_render_tiled_blits (basic) [87.075765] Starting subtest: basic [87.118190] Subtest basic: SUCCESS (0.042s) [87.234815] [039/162] (914s left) gem_ringfill (basic-all) [87.532803] Starting subtest: basic-all [88.677761] Subtest basic-all: SUCCESS (1.136s) [88.841056] [040/162] (913s left) gem_softpin (allocator-basic) [88.903387] Starting subtest: allocator-basic [89.049474] Subtest allocator-basic: SUCCESS (0.136s) [89.211566] [041/162] (912s left) gem_softpin (allocator-basic-reserve) [89.267575] Starting subtest: allocator-basic-reserve [89.406106] Subtest allocator-basic-reserve: SUCCESS (0.130s) [89.563940] [042/162] (912s left) gem_softpin (safe-alignment) [89.620415] Starting subtest: safe-alignment [89.638892] Subtest safe-alignment: SUCCESS (0.018s) [89.786540] [043/162] (912s left) gem_sync (basic-all) [89.847956] Starting subtest: basic-all [92.768940] Subtest basic-all: SUCCESS (2.920s) [93.027196] [044/162] (909s left) gem_sync (basic-each) [93.079205] Starting subtest: basic-each [95.961812] Subtest basic-each: SUCCESS (2.882s) [96.191293] [045/162] (906s left) gem_tiled_blits (basic) [96.309889] Starting subtest: basic [96.327300] Subtest basic: SUCCESS (0.018s) [96.526599] [046/162] (905s left) gem_tiled_fence_blits (basic) [96.692592] Starting subtest: basic [96.712574] Subtest basic: SUCCESS (0.020s) [96.869933] [047/162] (905s left) gem_tiled_pread_basic (basic) [96.958698] Subtest basic: SKIP (0.000s) [97.032819] [048/162] (905s left) gem_wait (busy@all-engines) [97.101886] Starting subtest: busy [97.102705] Starting dynamic subtest: all-engines [97.665102] Dynamic subtest all-engines: SUCCESS (0.562s) [97.666420] Subtest busy: SUCCESS (0.563s) [97.910009] [049/162] (904s left) gem_wait (wait@all-engines) [97.968941] Starting subtest: wait [97.969728] Starting dynamic subtest: all-engines [99.021755] Dynamic subtest all-engines: SUCCESS (1.053s) [99.023241] Subtest wait: SUCCESS (1.054s) [99.263183] [050/162] (903s left) i915_getparams_basic (basic-eu-total) [99.300521] Starting subtest: basic-eu-total [99.301963] Subtest basic-eu-total: SUCCESS (0.000s) [99.388416] [051/162] (903s left) i915_getparams_basic (basic-subslice-total) [99.424375] Starting subtest: basic-subslice-total [99.425879] Subtest basic-subslice-total: SUCCESS (0.000s) [99.559977] [052/162] (903s left) i915_hangman (error-state-basic) [99.608361] Starting subtest: error-state-basic [99.722331] Subtest error-state-basic: SUCCESS (0.113s) [99.832837] [053/162] (902s left) i915_pciid [99.967765] [054/162] (902s left) intel_hwmon (hwmon-read) [100.006830] Subtest hwmon-read: SKIP (0.000s) [100.070432] [055/162] (902s left) intel_hwmon (hwmon-write) [100.111349] Subtest hwmon-write: SKIP (0.000s) [100.173645] [056/162] (902s left) kms_addfb_basic (addfb25-4-tiled) [100.242695] Starting subtest: addfb25-4-tiled [100.243440] Subtest addfb25-4-tiled: SUCCESS (0.000s) [100.398690] [057/162] (902s left) kms_addfb_basic (addfb25-bad-modifier) [100.462599] Starting subtest: addfb25-bad-modifier [100.463448] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [100.594455] [058/162] (902s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [100.659895] Starting subtest: addfb25-framebuffer-vs-set-tiling [100.660994] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s) [100.788402] [059/162] (902s left) kms_addfb_basic (addfb25-modifier-no-flag) [100.856147] Starting subtest: addfb25-modifier-no-flag [100.857110] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [100.993766] [060/162] (901s left) kms_addfb_basic (addfb25-x-tiled-legacy) [101.060061] Starting subtest: addfb25-x-tiled-legacy [101.060920] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [101.204583] [061/162] (901s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [101.276617] Starting subtest: addfb25-x-tiled-mismatch-legacy [101.277452] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [101.411704] [062/162] (901s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [101.479851] Starting subtest: addfb25-yf-tiled-legacy [101.480695] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [101.618112] [063/162] (901s left) kms_addfb_basic (addfb25-y-tiled-legacy) [101.687862] Starting subtest: addfb25-y-tiled-legacy [101.688647] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [101.828931] [064/162] (901s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [101.900408] Starting subtest: addfb25-y-tiled-small-legacy [101.901345] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [102.030043] [065/162] (901s left) kms_addfb_basic (bad-pitch-0) [102.076322] Starting subtest: bad-pitch-0 [102.077134] Subtest bad-pitch-0: SUCCESS (0.000s) [102.240817] [066/162] (901s left) kms_addfb_basic (bad-pitch-1024) [102.286367] Starting subtest: bad-pitch-1024 [102.287133] Subtest bad-pitch-1024: SUCCESS (0.000s) [102.443581] [067/162] (900s left) kms_addfb_basic (bad-pitch-128) [102.489841] Starting subtest: bad-pitch-128 [102.490611] Subtest bad-pitch-128: SUCCESS (0.000s) [102.649027] [068/162] (900s left) kms_addfb_basic (bad-pitch-256) [102.693953] Starting subtest: bad-pitch-256 [102.694774] Subtest bad-pitch-256: SUCCESS (0.000s) [102.856752] [069/162] (900s left) kms_addfb_basic (bad-pitch-32) [102.903458] Starting subtest: bad-pitch-32 [102.904187] Subtest bad-pitch-32: SUCCESS (0.000s) [103.090694] [070/162] (900s left) kms_addfb_basic (bad-pitch-63) [103.134880] Starting subtest: bad-pitch-63 [103.135748] Subtest bad-pitch-63: SUCCESS (0.000s) [103.290515] [071/162] (900s left) kms_addfb_basic (bad-pitch-65536) [103.334686] Starting subtest: bad-pitch-65536 [103.336115] Subtest bad-pitch-65536: SUCCESS (0.000s) [103.524643] [072/162] (900s left) kms_addfb_basic (bad-pitch-999) [103.569269] Starting subtest: bad-pitch-999 [103.570024] Subtest bad-pitch-999: SUCCESS (0.000s) [103.732525] [073/162] (899s left) kms_addfb_basic (basic) [103.777288] Starting subtest: basic [103.778131] Subtest basic: SUCCESS (0.000s) [103.932786] [074/162] (899s left) kms_addfb_basic (basic-x-tiled-legacy) [103.978890] Starting subtest: basic-x-tiled-legacy [103.979719] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [104.131351] [075/162] (899s left) kms_addfb_basic (basic-y-tiled-legacy) [104.177429] Starting subtest: basic-y-tiled-legacy [104.178197] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [104.328587] [076/162] (899s left) kms_addfb_basic (bo-too-small) [104.395452] Starting subtest: bo-too-small [104.396377] Subtest bo-too-small: SUCCESS (0.000s) [104.539542] [077/162] (899s left) kms_addfb_basic (bo-too-small-due-to-tiling) [104.607938] Starting subtest: bo-too-small-due-to-tiling [104.608835] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [104.748327] [078/162] (899s left) kms_addfb_basic (clobberred-modifier) [104.794301] Starting subtest: clobberred-modifier [104.795063] Subtest clobberred-modifier: SUCCESS (0.000s) [104.985116] [079/162] (898s left) kms_addfb_basic (framebuffer-vs-set-tiling) [105.031231] Starting subtest: framebuffer-vs-set-tiling [105.031974] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [105.193801] [080/162] (898s left) kms_addfb_basic (invalid-get-prop) [105.237998] Starting subtest: invalid-get-prop [105.238780] Subtest invalid-get-prop: SUCCESS (0.000s) [105.395926] [081/162] (898s left) kms_addfb_basic (invalid-get-prop-any) [105.441994] Starting subtest: invalid-get-prop-any [105.442744] Subtest invalid-get-prop-any: SUCCESS (0.000s) [105.598677] [082/162] (898s left) kms_addfb_basic (invalid-set-prop) [105.643384] Starting subtest: invalid-set-prop [105.644146] Subtest invalid-set-prop: SUCCESS (0.000s) [105.832483] [083/162] (898s left) kms_addfb_basic (invalid-set-prop-any) [105.876237] Starting subtest: invalid-set-prop-any [105.877027] Subtest invalid-set-prop-any: SUCCESS (0.000s) [106.027482] [084/162] (898s left) kms_addfb_basic (no-handle) [106.071860] Starting subtest: no-handle [106.072625] Subtest no-handle: SUCCESS (0.000s) [106.240997] [085/162] (898s left) kms_addfb_basic (size-max) [106.307947] Starting subtest: size-max [106.308776] Subtest size-max: SUCCESS (0.000s) [106.449490] [086/162] (897s left) kms_addfb_basic (small-bo) [106.516927] Starting subtest: small-bo [106.517725] Subtest small-bo: SUCCESS (0.000s) [106.653538] [087/162] (897s left) kms_addfb_basic (tile-pitch-mismatch) [106.699125] Starting subtest: tile-pitch-mismatch [106.699867] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [106.853171] [088/162] (897s left) kms_addfb_basic (too-high) [106.922788] Starting subtest: too-high [106.923787] Subtest too-high: SUCCESS (0.001s) [107.057403] [089/162] (897s left) kms_addfb_basic (too-wide) [107.124697] Starting subtest: too-wide [107.125491] Subtest too-wide: SUCCESS (0.000s) [107.249686] [090/162] (897s left) kms_addfb_basic (unused-handle) [107.294812] Starting subtest: unused-handle [107.295591] Subtest unused-handle: SUCCESS (0.000s) [107.454474] [091/162] (897s left) kms_addfb_basic (unused-modifier) [107.500877] Starting subtest: unused-modifier [107.501770] Subtest unused-modifier: SUCCESS (0.000s) [107.661436] [092/162] (896s left) kms_addfb_basic (unused-offsets) [107.706964] Starting subtest: unused-offsets [107.708869] Subtest unused-offsets: SUCCESS (0.000s) [107.861034] [093/162] (896s left) kms_addfb_basic (unused-pitches) [107.907411] Starting subtest: unused-pitches [107.908178] Subtest unused-pitches: SUCCESS (0.000s) [108.062604] [094/162] (896s left) kms_busy (basic) [108.137035] Starting subtest: basic [108.137821] Starting dynamic subtest: flip [108.999297] Dynamic subtest flip: SUCCESS (0.861s) [109.011890] Starting dynamic subtest: modeset [112.662489] Dynamic subtest modeset: SUCCESS (3.663s) [112.663239] Subtest basic: SUCCESS (4.526s) [113.593079] [095/162] (891s left) kms_prop_blob (basic) [113.637586] Starting subtest: basic [113.638378] Subtest basic: SUCCESS (0.000s) [113.740058] [096/162] (891s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [113.845173] Starting subtest: basic-busy-flip-before-cursor-atomic [113.846991] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [114.012706] [097/162] (890s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [114.116379] Starting subtest: basic-busy-flip-before-cursor-legacy [114.117828] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [114.284306] [098/162] (890s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [114.384592] Starting subtest: basic-flip-after-cursor-atomic [115.609473] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.224s) [116.500729] [099/162] (888s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [116.606558] Starting subtest: basic-flip-after-cursor-legacy [117.818338] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.211s) [118.710509] [100/162] (886s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [118.814490] Starting subtest: basic-flip-after-cursor-varying-size [120.024400] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.209s) [120.959512] [101/162] (884s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [121.058420] Starting subtest: basic-flip-before-cursor-atomic [122.284529] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.225s) [123.204282] [102/162] (881s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [123.308164] Starting subtest: basic-flip-before-cursor-legacy [124.530501] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.221s) [125.450509] [103/162] (879s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [125.556079] Starting subtest: basic-flip-before-cursor-varying-size [126.756982] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.202s) [127.696526] [104/162] (877s left) kms_dsc (dsc-basic) [127.760701] Starting subtest: dsc-basic [127.764254] Subtest dsc-basic: SKIP (0.001s) [127.861845] [105/162] (877s left) kms_flip (basic-flip-vs-dpms) [127.919416] Starting subtest: basic-flip-vs-dpms [127.920936] Starting dynamic subtest: A-eDP1 [130.675604] Dynamic subtest A-eDP1: SUCCESS (2.755s) [130.688410] Starting dynamic subtest: B-eDP1 [133.047900] Dynamic subtest B-eDP1: SUCCESS (2.371s) [133.069389] Starting dynamic subtest: C-eDP1 [135.415829] Dynamic subtest C-eDP1: SUCCESS (2.366s) [135.416946] Subtest basic-flip-vs-dpms: SUCCESS (7.498s) [136.360578] [106/162] (868s left) kms_flip (basic-flip-vs-modeset) [136.424871] Starting subtest: basic-flip-vs-modeset [136.426146] Starting dynamic subtest: A-eDP1 [139.222161] Dynamic subtest A-eDP1: SUCCESS (2.796s) [139.236183] Starting dynamic subtest: B-eDP1 [141.594410] Dynamic subtest B-eDP1: SUCCESS (2.371s) [141.607851] Starting dynamic subtest: C-eDP1 [143.949254] Dynamic subtest C-eDP1: SUCCESS (2.353s) [143.952722] Subtest basic-flip-vs-modeset: SUCCESS (7.527s) [144.897020] [107/162] (860s left) kms_flip (basic-flip-vs-wf_vblank) [144.962808] Starting subtest: basic-flip-vs-wf_vblank [144.963660] Starting dynamic subtest: A-eDP1 [147.212108] Dynamic subtest A-eDP1: SUCCESS (2.247s) [147.225842] Starting dynamic subtest: B-eDP1 [149.447784] Dynamic subtest B-eDP1: SUCCESS (2.233s) [149.471226] Starting dynamic subtest: C-eDP1 [151.675605] Dynamic subtest C-eDP1: SUCCESS (2.224s) [151.679119] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.717s) [152.927724] [108/162] (852s left) kms_flip (basic-plain-flip) [152.995856] Starting subtest: basic-plain-flip [152.997690] Starting dynamic subtest: A-eDP1 [154.959446] Dynamic subtest A-eDP1: SUCCESS (1.961s) [154.982184] Starting dynamic subtest: B-eDP1 [156.881818] Dynamic subtest B-eDP1: SUCCESS (1.920s) [156.903445] Starting dynamic subtest: C-eDP1 [158.803708] Dynamic subtest C-eDP1: SUCCESS (1.920s) [158.806834] Subtest basic-plain-flip: SUCCESS (5.811s) [160.015233] [109/162] (845s left) kms_force_connector_basic (force-connector-state) [160.070802] Starting subtest: force-connector-state [160.570784] Subtest force-connector-state: SUCCESS (0.500s) [161.747755] [110/162] (843s left) kms_force_connector_basic (force-edid) [161.805177] Starting subtest: force-edid [161.840377] Subtest force-edid: SUCCESS (0.037s) [161.994870] [111/162] (843s left) kms_force_connector_basic (force-load-detect) [162.045742] Starting subtest: force-load-detect [162.047529] Subtest force-load-detect: SKIP (0.000s) [162.185772] [112/162] (843s left) kms_force_connector_basic (prune-stale-modes) [162.237059] Starting subtest: prune-stale-modes [162.266453] Subtest prune-stale-modes: SUCCESS (0.031s) [162.417543] [113/162] (843s left) kms_frontbuffer_tracking (basic) [162.483911] Starting subtest: basic [168.208218] Subtest basic: SUCCESS (5.722s) [168.345555] [114/162] (837s left) kms_hdmi_inject (inject-audio) [168.703156] Starting subtest: inject-audio [168.856804] Subtest inject-audio: SUCCESS (0.155s) [169.676052] [115/162] (836s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [169.737941] Starting subtest: compare-crc-sanitycheck-xr24 [169.738722] Starting dynamic subtest: pipe-A-eDP-1 [170.602887] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.857s) [170.615630] Starting dynamic subtest: pipe-B-eDP-1 [172.099161] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.500s) [172.114086] Starting dynamic subtest: pipe-C-eDP-1 [173.501251] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s) [173.502069] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.765s) [174.369392] [116/162] (831s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [174.436741] Starting subtest: compare-crc-sanitycheck-nv12 [174.437870] Starting dynamic subtest: pipe-A-eDP-1 [175.477365] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.037s) [175.502290] Starting dynamic subtest: pipe-B-eDP-1 [176.953934] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.474s) [176.967483] Starting dynamic subtest: pipe-C-eDP-1 [178.375087] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.420s) [178.375878] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.940s) [179.311988] [117/162] (826s left) kms_pipe_crc_basic (hang-read-crc) [179.373648] Starting subtest: hang-read-crc [179.374923] Starting dynamic subtest: pipe-A-eDP-1 [181.803974] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.429s) [181.818531] Starting dynamic subtest: pipe-B-eDP-1 [184.858834] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.052s) [184.875842] Starting dynamic subtest: pipe-C-eDP-1 [187.930724] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.069s) [187.931467] Subtest hang-read-crc: SUCCESS (8.559s) [188.841505] [118/162] (817s left) kms_pipe_crc_basic (nonblocking-crc) [188.908657] Starting subtest: nonblocking-crc [188.909432] Starting dynamic subtest: pipe-A-eDP-1 [189.879214] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.969s) [189.896196] Starting dynamic subtest: pipe-B-eDP-1 [191.588922] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.705s) [191.608338] Starting dynamic subtest: pipe-C-eDP-1 [193.116091] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.525s) [193.116923] Subtest nonblocking-crc: SUCCESS (4.210s) [194.049943] [119/162] (811s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [194.119059] Starting subtest: nonblocking-crc-frame-sequence [194.120455] Starting dynamic subtest: pipe-A-eDP-1 [195.112417] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.992s) [195.142996] Starting dynamic subtest: pipe-B-eDP-1 [196.754920] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.638s) [196.775844] Starting dynamic subtest: pipe-C-eDP-1 [198.302673] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.542s) [198.303449] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.185s) [199.231389] [120/162] (806s left) kms_pipe_crc_basic (read-crc) [199.299028] Starting subtest: read-crc [199.301153] Starting dynamic subtest: pipe-A-eDP-1 [200.195323] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.893s) [200.214145] Starting dynamic subtest: pipe-B-eDP-1 [201.702421] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.502s) [201.719345] Starting dynamic subtest: pipe-C-eDP-1 [203.181080] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.475s) [203.182171] Subtest read-crc: SUCCESS (3.883s) [204.043828] [121/162] (801s left) kms_pipe_crc_basic (read-crc-frame-sequence) [204.111075] Starting subtest: read-crc-frame-sequence [204.112129] Starting dynamic subtest: pipe-A-eDP-1 [205.013695] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.901s) [205.027245] Starting dynamic subtest: pipe-B-eDP-1 [206.517891] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.502s) [206.532197] Starting dynamic subtest: pipe-C-eDP-1 [208.012219] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.491s) [208.013373] Subtest read-crc-frame-sequence: SUCCESS (3.903s) [208.883242] [122/162] (797s left) kms_pm_backlight (basic-brightness) [208.949360] Starting subtest: basic-brightness [209.005116] Starting dynamic subtest: eDP-1 [209.339740] Dynamic subtest eDP-1: SUCCESS (0.336s) [209.341040] Subtest basic-brightness: SUCCESS (0.390s) [210.279098] [123/162] (795s left) kms_pm_rpm (basic-pci-d3-state) [211.793404] Starting subtest: basic-pci-d3-state [213.284501] Subtest basic-pci-d3-state: SUCCESS (1.491s) [213.418982] [124/162] (792s left) kms_pm_rpm (basic-rte) [213.459225] Starting subtest: basic-rte [216.449194] Subtest basic-rte: SUCCESS (2.988s) [217.932545] [125/162] (788s left) kms_psr (psr-primary-page-flip) [217.996640] Starting subtest: psr-primary-page-flip [217.997405] Starting dynamic subtest: eDP-1 [219.908819] Dynamic subtest eDP-1: SUCCESS (1.909s) [219.910141] Subtest psr-primary-page-flip: SUCCESS (1.911s) [220.841028] [126/162] (785s left) kms_psr (psr-cursor-plane-move) [220.908450] Starting subtest: psr-cursor-plane-move [220.911066] Starting dynamic subtest: eDP-1 [222.799275] Dynamic subtest eDP-1: SUCCESS (1.887s) [222.800327] Subtest psr-cursor-plane-move: SUCCESS (1.890s) [223.746904] [127/162] (782s left) kms_psr (psr-sprite-plane-onoff) [223.814319] Starting subtest: psr-sprite-plane-onoff [223.816819] Starting dynamic subtest: eDP-1 [225.807324] Dynamic subtest eDP-1: SUCCESS (1.991s) [225.808119] Subtest psr-sprite-plane-onoff: SUCCESS (1.993s) [226.669050] [128/162] (779s left) kms_psr (psr-primary-mmap-gtt) [226.737477] Starting subtest: psr-primary-mmap-gtt [226.738301] Starting dynamic subtest: eDP-1 [228.635415] Dynamic subtest eDP-1: SUCCESS (1.897s) [228.636212] Subtest psr-primary-mmap-gtt: SUCCESS (1.899s) [229.573556] [129/162] (776s left) kms_setmode (basic-clone-single-crtc) [229.616843] Starting subtest: basic-clone-single-crtc [229.619203] Subtest basic-clone-single-crtc: SKIP (0.000s) [229.719968] [130/162] (776s left) i915_pm_rps (basic-api) [229.766704] Starting subtest: basic-api [229.768531] Subtest basic-api: SKIP (0.001s) [229.869195] [131/162] (776s left) prime_self_import (basic-llseek-bad) [229.906810] Starting subtest: basic-llseek-bad [229.908383] Subtest basic-llseek-bad: SUCCESS (0.002s) [230.037861] [132/162] (776s left) prime_self_import (basic-llseek-size) [230.074524] Starting subtest: basic-llseek-size [230.078121] Subtest basic-llseek-size: SUCCESS (0.004s) [230.204108] [133/162] (776s left) prime_self_import (basic-with_fd_dup) [230.240384] Starting subtest: basic-with_fd_dup [230.243599] Subtest basic-with_fd_dup: SUCCESS (0.003s) [230.371387] [134/162] (776s left) prime_self_import (basic-with_one_bo) [230.409264] Starting subtest: basic-with_one_bo [230.412187] Subtest basic-with_one_bo: SUCCESS (0.004s) [230.545446] [135/162] (776s left) prime_self_import (basic-with_one_bo_two_files) [230.582860] Starting subtest: basic-with_one_bo_two_files [230.586342] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [230.704398] [136/162] (775s left) prime_self_import (basic-with_two_bos) [230.740439] Starting subtest: basic-with_two_bos [230.743957] Subtest basic-with_two_bos: SUCCESS (0.003s) [230.866414] [137/162] (775s left) prime_vgem (basic-fence-flip) [230.922799] Starting subtest: basic-fence-flip [231.361672] Subtest basic-fence-flip: SUCCESS (0.439s) [231.483477] [138/162] (775s left) prime_vgem (basic-fence-mmap) [231.536509] Starting subtest: basic-fence-mmap [231.562771] Subtest basic-fence-mmap: SUCCESS (0.026s) [231.687428] [139/162] (775s left) prime_vgem (basic-fence-read) [231.737913] Starting subtest: basic-fence-read [231.747247] Subtest basic-fence-read: SKIP (0.009s) [231.886926] [140/162] (774s left) prime_vgem (basic-gtt) [231.937050] Starting subtest: basic-gtt [231.951183] Subtest basic-gtt: SUCCESS (0.015s) [232.068779] [141/162] (774s left) prime_vgem (basic-read) [232.119343] Starting subtest: basic-read [232.127379] Subtest basic-read: SKIP (0.007s) [232.251154] [142/162] (774s left) prime_vgem (basic-write) [232.303469] Starting subtest: basic-write [232.311512] Subtest basic-write: SKIP (0.007s) [232.434426] [143/162] (774s left) vgem_basic (setversion) [232.480729] Starting subtest: setversion [232.482203] Subtest setversion: SUCCESS (0.000s) [232.565288] [144/162] (774s left) vgem_basic (create) [232.612521] Starting subtest: create [232.613442] Subtest create: SUCCESS (0.001s) [232.739701] [145/162] (774s left) vgem_basic (debugfs) [232.780216] Starting subtest: debugfs [232.781111] Subtest debugfs: SUCCESS (0.000s) [232.869605] [146/162] (774s left) vgem_basic (dmabuf-export) [232.912126] Starting subtest: dmabuf-export [232.915568] Subtest dmabuf-export: SUCCESS (0.003s) [233.035081] [147/162] (774s left) vgem_basic (dmabuf-fence) [233.080917] Starting subtest: dmabuf-fence [233.081767] Subtest dmabuf-fence: SUCCESS (0.001s) [233.169834] [148/162] (774s left) vgem_basic (dmabuf-fence-before) [233.212175] Starting subtest: dmabuf-fence-before [233.213035] Subtest dmabuf-fence-before: SUCCESS (0.001s) [233.298262] [149/162] (774s left) vgem_basic (dmabuf-mmap) [233.345721] Starting subtest: dmabuf-mmap [233.360172] Subtest dmabuf-mmap: SUCCESS (0.014s) [233.484857] [150/162] (773s left) vgem_basic (mmap) [233.530538] Starting subtest: mmap [233.537866] Subtest mmap: SUCCESS (0.009s) [233.611142] [151/162] (773s left) vgem_basic (second-client) [233.662404] Starting subtest: second-client [233.699696] Subtest second-client: SUCCESS (0.034s) [233.803867] [152/162] (773s left) vgem_basic (sysfs) [233.845359] Starting subtest: sysfs [233.846253] Subtest sysfs: SUCCESS (0.001s) [233.933039] [153/162] (773s left) core_hotunplug (unbind-rebind) [234.031099] Starting subtest: unbind-rebind [239.319789] Subtest unbind-rebind: SUCCESS (5.289s) [239.369177] [154/162] (768s left) vgem_basic (unload) [239.408879] Starting subtest: unload [268.447240] Subtest unload: SUCCESS (29.004s) [268.581064] [155/162] (739s left) i915_module_load (reload) [268.622403] Starting subtest: reload [272.113080] Subtest reload: SUCCESS (3.485s) [272.159466] [156/162] (735s left) gem_lmem_swapping (basic) [272.208491] Subtest basic: SKIP (0.000s) [272.260457] [157/162] (735s left) gem_lmem_swapping (parallel-random-engines) [272.302422] Subtest parallel-random-engines: SKIP (0.000s) [272.360398] [158/162] (735s left) gem_lmem_swapping (random-engines) [272.402924] Subtest random-engines: SKIP (0.000s) [272.460844] [159/162] (735s left) gem_lmem_swapping (verify-random) [272.503184] Subtest verify-random: SKIP (0.000s) [272.561446] [160/162] (735s left) i915_pm_rpm (module-reload) [274.782061] Starting subtest: module-reload [287.237334] Subtest module-reload: SUCCESS (12.446s) [287.272745] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [287.273979] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [287.277324] [161/162] (720s left) i915_selftest (live)