[69.666267] Initializing watchdogs [69.666319] /dev/watchdog0 [69.678615] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:46a6 Intel Alderlake_p (Gen12) Alder Lake-P GT2 [Iris Xe Graphics] [69.682296] [001/161] (960s left) i915_module_load (load) [69.798358] Starting subtest: load [78.310281] Subtest load: SUCCESS (8.512s) [78.353103] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [78.354467] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [78.357175] [002/161] (951s left) core_auth (basic-auth) [78.390913] Starting subtest: basic-auth [78.391707] Subtest basic-auth: SUCCESS (0.000s) [78.479914] [003/161] (951s left) debugfs_test (read_all_entries) [78.518683] Starting subtest: read_all_entries [78.785330] Subtest read_all_entries: SUCCESS (0.267s) [80.884658] [004/161] (949s left) debugfs_test (basic-hwmon) [80.917566] Starting subtest: basic-hwmon [80.919011] Subtest basic-hwmon: SKIP (0.000s) [82.997890] [005/161] (947s left) debugfs_test (sysfs) [83.035272] Starting subtest: sysfs [83.070738] Subtest sysfs: SUCCESS (0.035s) [85.152808] [006/161] (945s left) fbdev (eof) [85.187011] Starting subtest: eof [85.187680] Subtest eof: SUCCESS (0.000s) [85.251149] [007/161] (945s left) fbdev (info) [85.276843] Starting subtest: info [85.277697] Subtest info: SUCCESS (0.000s) [85.354972] [008/161] (945s left) fbdev (nullptr) [85.401684] Starting subtest: nullptr [85.402584] Subtest nullptr: SUCCESS (0.000s) [85.476359] [009/161] (944s left) fbdev (read) [85.520156] Starting subtest: read [87.969774] Subtest read: SUCCESS (2.440s) [88.042291] [010/161] (942s left) fbdev (write) [88.090706] Starting subtest: write [89.739322] Subtest write: SUCCESS (1.640s) [89.812625] [011/161] (940s left) gem_basic (bad-close) [89.840113] Starting subtest: bad-close [89.841361] Subtest bad-close: SUCCESS (0.000s) [89.923168] [012/161] (940s left) gem_basic (create-close) [89.950311] Starting subtest: create-close [89.951720] Subtest create-close: SUCCESS (0.000s) [90.077406] [013/161] (940s left) gem_basic (create-fd-close) [90.104627] Starting subtest: create-fd-close [90.106093] Subtest create-fd-close: SUCCESS (0.000s) [90.230256] [014/161] (940s left) gem_busy (busy@all-engines) [90.267085] Starting subtest: busy [90.267747] Starting dynamic subtest: all-engines [90.296198] Dynamic subtest all-engines: SUCCESS (0.029s) [90.296938] Subtest busy: SUCCESS (0.029s) [90.693129] [015/161] (939s left) gem_close_race (basic-process) [90.728559] Starting subtest: basic-process [90.796576] Subtest basic-process: SUCCESS (0.067s) [90.993302] [016/161] (939s left) gem_close_race (basic-threads) [91.030249] Starting subtest: basic-threads [92.346494] Subtest basic-threads: SUCCESS (1.315s) [92.544263] [017/161] (938s left) gem_ctx_create (basic) [92.579264] Starting subtest: basic [92.580037] Subtest basic: SUCCESS (0.000s) [92.782171] [018/161] (937s left) gem_ctx_create (basic-files) [92.815547] Starting subtest: basic-files [94.824768] Subtest basic-files: SUCCESS (2.010s) [95.195953] [019/161] (935s left) gem_ctx_exec (basic) [95.225654] Starting subtest: basic [95.227931] Subtest basic: SUCCESS (0.003s) [95.387989] [020/161] (935s left) gem_exec_basic (basic) [95.419101] Starting subtest: basic [95.419897] Starting dynamic subtest: rcs0-smem [95.420553] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [95.425695] Starting dynamic subtest: bcs0-smem [95.426299] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [95.431116] Starting dynamic subtest: vcs0-smem [95.431738] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [95.436488] Starting dynamic subtest: vcs1-smem [95.437103] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [95.441841] Starting dynamic subtest: vecs0-smem [95.442447] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [95.443070] Subtest basic: SUCCESS (0.002s) [95.623008] [021/161] (935s left) gem_exec_create (basic) [95.660948] Starting subtest: basic [95.661936] Starting dynamic subtest: smem [97.749544] Dynamic subtest smem: SUCCESS (2.088s) [97.750933] Subtest basic: SUCCESS (2.088s) [97.947208] [022/161] (932s left) gem_exec_fence (basic-busy) [98.100442] Starting subtest: basic-busy [98.101558] Starting dynamic subtest: rcs0 [98.153643] Dynamic subtest rcs0: SUCCESS (0.053s) [98.166638] Starting dynamic subtest: bcs0 [98.214962] Dynamic subtest bcs0: SUCCESS (0.061s) [98.228109] Starting dynamic subtest: vcs0 [98.280840] Dynamic subtest vcs0: SUCCESS (0.065s) [98.293980] Starting dynamic subtest: vcs1 [98.341853] Dynamic subtest vcs1: SUCCESS (0.061s) [98.355094] Starting dynamic subtest: vecs0 [98.397808] Dynamic subtest vecs0: SUCCESS (0.056s) [98.399360] Subtest basic-busy: SUCCESS (0.297s) [98.933088] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [98.934852] [023/161] (931s left) gem_exec_fence (basic-wait) [99.086339] Starting subtest: basic-wait [99.087290] Starting dynamic subtest: rcs0 [99.180441] Dynamic subtest rcs0: SUCCESS (0.093s) [99.193951] Starting dynamic subtest: bcs0 [99.233613] Dynamic subtest bcs0: SUCCESS (0.053s) [99.249562] Starting dynamic subtest: vcs0 [99.286662] Dynamic subtest vcs0: SUCCESS (0.053s) [99.296095] Starting dynamic subtest: vcs1 [99.334635] Dynamic subtest vcs1: SUCCESS (0.048s) [99.346479] Starting dynamic subtest: vecs0 [99.383785] Dynamic subtest vecs0: SUCCESS (0.049s) [99.385187] Subtest basic-wait: SUCCESS (0.297s) [99.883316] [024/161] (930s left) gem_exec_fence (basic-await) [100.038276] Starting subtest: basic-await [100.039031] Starting dynamic subtest: rcs0 [100.112706] Dynamic subtest rcs0: SUCCESS (0.076s) [100.122066] Starting dynamic subtest: bcs0 [100.191111] Dynamic subtest bcs0: SUCCESS (0.078s) [100.198985] Starting dynamic subtest: vcs0 [100.265972] Dynamic subtest vcs0: SUCCESS (0.075s) [100.275040] Starting dynamic subtest: vcs1 [100.342944] Dynamic subtest vcs1: SUCCESS (0.077s) [100.354530] Starting dynamic subtest: vecs0 [100.422984] Dynamic subtest vecs0: SUCCESS (0.079s) [100.424546] Subtest basic-await: SUCCESS (0.385s) [100.945653] [025/161] (929s left) gem_exec_fence (nb-await) [101.099225] Starting subtest: nb-await [101.100136] Starting dynamic subtest: rcs0 [101.156725] Dynamic subtest rcs0: SUCCESS (0.057s) [101.170031] Starting dynamic subtest: bcs0 [101.215307] Dynamic subtest bcs0: SUCCESS (0.058s) [101.224761] Starting dynamic subtest: vcs0 [101.276099] Dynamic subtest vcs0: SUCCESS (0.060s) [101.288874] Starting dynamic subtest: vcs1 [101.335172] Dynamic subtest vcs1: SUCCESS (0.059s) [101.348081] Starting dynamic subtest: vecs0 [101.393563] Dynamic subtest vecs0: SUCCESS (0.058s) [101.394865] Subtest nb-await: SUCCESS (0.294s) [101.914438] [026/161] (928s left) gem_exec_gttfill (basic) [101.952349] Starting subtest: basic [105.918455] Subtest basic: SUCCESS (3.958s) [106.106466] [027/161] (924s left) gem_exec_parallel (engines) [106.188865] Starting subtest: engines [106.189727] Starting dynamic subtest: basic [107.598042] Dynamic subtest basic: SUCCESS (1.409s) [107.603966] Starting dynamic subtest: contexts [109.337984] Dynamic subtest contexts: SUCCESS (1.731s) [109.345730] Starting dynamic subtest: fds [111.118621] Dynamic subtest fds: SUCCESS (1.780s) [111.131396] Starting dynamic subtest: userptr [112.473149] Dynamic subtest userptr: SUCCESS (1.364s) [112.474164] Subtest engines: SUCCESS (6.284s) [112.686018] [028/161] (918s left) gem_exec_store (basic) [112.725691] Starting subtest: basic [112.785620] Subtest basic: SUCCESS (0.059s) [112.985693] [029/161] (918s left) gem_flink_basic (bad-flink) [113.015225] Starting subtest: bad-flink [113.015959] Subtest bad-flink: SUCCESS (0.000s) [113.102866] [030/161] (917s left) gem_flink_basic (bad-open) [113.133938] Starting subtest: bad-open [113.134844] Subtest bad-open: SUCCESS (0.000s) [113.217954] [031/161] (917s left) gem_flink_basic (basic) [113.248091] Starting subtest: basic [113.248876] Subtest basic: SUCCESS (0.000s) [113.376127] [032/161] (917s left) gem_flink_basic (double-flink) [113.405346] Starting subtest: double-flink [113.406115] Subtest double-flink: SUCCESS (0.000s) [113.531020] [033/161] (917s left) gem_flink_basic (flink-lifetime) [113.560877] Starting subtest: flink-lifetime [113.561661] Subtest flink-lifetime: SUCCESS (0.001s) [113.688886] [034/161] (917s left) gem_huc_copy (huc-copy) [113.721160] Starting subtest: huc-copy [113.722801] Subtest huc-copy: SUCCESS (0.002s) [113.863732] [035/161] (917s left) gem_linear_blits (basic) [113.969405] Starting subtest: basic [113.975231] Subtest basic: SUCCESS (0.006s) [114.151045] [036/161] (917s left) gem_mmap (basic) [114.221130] Starting subtest: basic [114.224071] Subtest basic: SUCCESS (0.000s) [114.338531] [037/161] (916s left) gem_mmap_gtt (basic) [114.368836] Starting subtest: basic [114.369713] Subtest basic: SUCCESS (0.000s) [114.448939] [038/161] (916s left) gem_render_linear_blits (basic) [114.488318] Starting subtest: basic [114.508189] Subtest basic: SUCCESS (0.020s) [114.614579] [039/161] (916s left) gem_render_tiled_blits (basic) [114.647138] Starting subtest: basic [114.672327] Subtest basic: SUCCESS (0.025s) [114.768201] [040/161] (916s left) gem_ringfill (basic-all) [115.101870] Starting subtest: basic-all [116.249280] Subtest basic-all: SUCCESS (1.141s) [116.413702] [041/161] (914s left) gem_softpin (allocator-basic) [116.449816] Starting subtest: allocator-basic [116.500229] Subtest allocator-basic: SUCCESS (0.050s) [116.661743] [042/161] (914s left) gem_softpin (allocator-basic-reserve) [116.693686] Starting subtest: allocator-basic-reserve [116.742128] Subtest allocator-basic-reserve: SUCCESS (0.048s) [116.885353] [043/161] (914s left) gem_softpin (safe-alignment) [116.920847] Starting subtest: safe-alignment [116.928198] Subtest safe-alignment: SUCCESS (0.007s) [117.086427] [044/161] (914s left) gem_sync (basic-all) [117.128110] Starting subtest: basic-all [119.475787] Subtest basic-all: SUCCESS (2.347s) [119.679319] [045/161] (911s left) gem_sync (basic-each) [119.718201] Starting subtest: basic-each [121.864980] Subtest basic-each: SUCCESS (2.146s) [122.072676] [046/161] (909s left) gem_tiled_blits (basic) [122.157409] Starting subtest: basic [122.168583] Subtest basic: SUCCESS (0.012s) [122.332577] [047/161] (909s left) gem_tiled_fence_blits (basic) [122.485835] Starting subtest: basic [122.504298] Subtest basic: SUCCESS (0.019s) [122.679371] [048/161] (908s left) gem_tiled_pread_basic [122.831076] [049/161] (908s left) gem_wait (busy@all-engines) [122.872016] Starting subtest: busy [122.872909] Starting dynamic subtest: all-engines [123.446410] Dynamic subtest all-engines: SUCCESS (0.573s) [123.448028] Subtest busy: SUCCESS (0.574s) [123.668345] [050/161] (907s left) gem_wait (wait@all-engines) [123.707918] Starting subtest: wait [123.708722] Starting dynamic subtest: all-engines [124.779181] Dynamic subtest all-engines: SUCCESS (1.070s) [124.780966] Subtest wait: SUCCESS (1.071s) [125.001675] [051/161] (906s left) i915_getparams_basic (basic-eu-total) [125.031817] Starting subtest: basic-eu-total [125.033289] Subtest basic-eu-total: SUCCESS (0.000s) [125.114290] [052/161] (906s left) i915_getparams_basic (basic-subslice-total) [125.141860] Starting subtest: basic-subslice-total [125.143406] Subtest basic-subslice-total: SUCCESS (0.000s) [125.231071] [053/161] (906s left) i915_hangman (error-state-basic) [125.264868] Starting subtest: error-state-basic [125.351135] Subtest error-state-basic: SUCCESS (0.087s) [125.453099] [054/161] (906s left) i915_pciid [125.578147] [055/161] (906s left) kms_addfb_basic (addfb25-4-tiled) [127.541956] Starting subtest: addfb25-4-tiled [127.542631] Subtest addfb25-4-tiled: SUCCESS (0.000s) [127.684181] [056/161] (904s left) kms_addfb_basic (addfb25-bad-modifier) [129.646998] Starting subtest: addfb25-bad-modifier [129.647830] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [129.784926] [057/161] (902s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [131.746930] Starting subtest: addfb25-framebuffer-vs-set-tiling [131.747833] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [131.877340] [058/161] (899s left) kms_addfb_basic (addfb25-modifier-no-flag) [133.838691] Starting subtest: addfb25-modifier-no-flag [133.839353] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [133.948062] [059/161] (897s left) kms_addfb_basic (addfb25-x-tiled-legacy) [135.912202] Starting subtest: addfb25-x-tiled-legacy [135.912945] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [136.030968] [060/161] (895s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [137.990986] Starting subtest: addfb25-x-tiled-mismatch-legacy [137.991724] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [138.119445] [061/161] (893s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [140.083559] Starting subtest: addfb25-yf-tiled-legacy [140.084440] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [140.216653] [062/161] (891s left) kms_addfb_basic (addfb25-y-tiled-legacy) [142.177993] Starting subtest: addfb25-y-tiled-legacy [142.178673] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [142.305111] [063/161] (889s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [144.273866] Starting subtest: addfb25-y-tiled-small-legacy [144.274581] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [144.401114] [064/161] (887s left) kms_addfb_basic (bad-pitch-0) [144.432830] Starting subtest: bad-pitch-0 [144.433678] Subtest bad-pitch-0: SUCCESS (0.000s) [146.498041] [065/161] (885s left) kms_addfb_basic (bad-pitch-1024) [146.525913] Starting subtest: bad-pitch-1024 [146.526860] Subtest bad-pitch-1024: SUCCESS (0.000s) [148.575063] [066/161] (883s left) kms_addfb_basic (bad-pitch-128) [148.603493] Starting subtest: bad-pitch-128 [148.604169] Subtest bad-pitch-128: SUCCESS (0.000s) [150.654622] [067/161] (881s left) kms_addfb_basic (bad-pitch-256) [150.683779] Starting subtest: bad-pitch-256 [150.684471] Subtest bad-pitch-256: SUCCESS (0.000s) [152.745940] [068/161] (879s left) kms_addfb_basic (bad-pitch-32) [152.773462] Starting subtest: bad-pitch-32 [152.774184] Subtest bad-pitch-32: SUCCESS (0.000s) [154.842805] [069/161] (877s left) kms_addfb_basic (bad-pitch-63) [154.879628] Starting subtest: bad-pitch-63 [154.880294] Subtest bad-pitch-63: SUCCESS (0.000s) [156.929604] [070/161] (875s left) kms_addfb_basic (bad-pitch-65536) [156.960488] Starting subtest: bad-pitch-65536 [156.961194] Subtest bad-pitch-65536: SUCCESS (0.000s) [159.021994] [071/161] (873s left) kms_addfb_basic (bad-pitch-999) [159.054020] Starting subtest: bad-pitch-999 [159.055041] Subtest bad-pitch-999: SUCCESS (0.000s) [161.115224] [072/161] (871s left) kms_addfb_basic (basic) [161.143984] Starting subtest: basic [161.144759] Subtest basic: SUCCESS (0.000s) [163.203809] [073/161] (869s left) kms_addfb_basic (basic-x-tiled-legacy) [163.231582] Starting subtest: basic-x-tiled-legacy [163.232265] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [165.273806] [074/161] (867s left) kms_addfb_basic (basic-y-tiled-legacy) [165.303541] Starting subtest: basic-y-tiled-legacy [165.304217] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [167.369396] [075/161] (865s left) kms_addfb_basic (bo-too-small) [169.331876] Starting subtest: bo-too-small [169.332517] Subtest bo-too-small: SUCCESS (0.000s) [169.454226] [076/161] (862s left) kms_addfb_basic (bo-too-small-due-to-tiling) [171.417893] Starting subtest: bo-too-small-due-to-tiling [171.418652] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [171.537882] [077/161] (860s left) kms_addfb_basic (clobberred-modifier) [171.566972] Starting subtest: clobberred-modifier [171.567727] Subtest clobberred-modifier: SUCCESS (0.000s) [173.635065] [078/161] (858s left) kms_addfb_basic (framebuffer-vs-set-tiling) [173.662618] Starting subtest: framebuffer-vs-set-tiling [173.663227] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [175.718871] [079/161] (856s left) kms_addfb_basic (invalid-get-prop) [175.748087] Starting subtest: invalid-get-prop [175.748957] Subtest invalid-get-prop: SUCCESS (0.000s) [177.807902] [080/161] (854s left) kms_addfb_basic (invalid-get-prop-any) [177.836834] Starting subtest: invalid-get-prop-any [177.837567] Subtest invalid-get-prop-any: SUCCESS (0.000s) [179.901522] [081/161] (852s left) kms_addfb_basic (invalid-set-prop) [179.930477] Starting subtest: invalid-set-prop [179.931201] Subtest invalid-set-prop: SUCCESS (0.000s) [182.002819] [082/161] (850s left) kms_addfb_basic (invalid-set-prop-any) [182.030990] Starting subtest: invalid-set-prop-any [182.031759] Subtest invalid-set-prop-any: SUCCESS (0.000s) [184.103201] [083/161] (848s left) kms_addfb_basic (no-handle) [184.132444] Starting subtest: no-handle [184.133156] Subtest no-handle: SUCCESS (0.000s) [186.210141] [084/161] (846s left) kms_addfb_basic (size-max) [188.169954] Starting subtest: size-max [188.170630] Subtest size-max: SUCCESS (0.000s) [188.292801] [085/161] (844s left) kms_addfb_basic (small-bo) [190.253930] Starting subtest: small-bo [190.254740] Subtest small-bo: SUCCESS (0.000s) [190.382847] [086/161] (842s left) kms_addfb_basic (tile-pitch-mismatch) [190.412928] Starting subtest: tile-pitch-mismatch [190.413628] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [192.487478] [087/161] (840s left) kms_addfb_basic (too-high) [194.456038] Starting subtest: too-high [194.456860] Subtest too-high: SUCCESS (0.000s) [194.567858] [088/161] (838s left) kms_addfb_basic (too-wide) [196.529025] Starting subtest: too-wide [196.529742] Subtest too-wide: SUCCESS (0.000s) [196.656751] [089/161] (836s left) kms_addfb_basic (unused-handle) [196.685908] Starting subtest: unused-handle [196.686693] Subtest unused-handle: SUCCESS (0.000s) [198.750947] [090/161] (834s left) kms_addfb_basic (unused-modifier) [198.779955] Starting subtest: unused-modifier [198.780747] Subtest unused-modifier: SUCCESS (0.000s) [200.824924] [091/161] (832s left) kms_addfb_basic (unused-offsets) [200.853250] Starting subtest: unused-offsets [200.854114] Subtest unused-offsets: SUCCESS (0.000s) [202.937125] [092/161] (829s left) kms_addfb_basic (unused-pitches) [202.970719] Starting subtest: unused-pitches [202.971513] Subtest unused-pitches: SUCCESS (0.000s) [205.016305] [093/161] (827s left) kms_busy (basic) [206.982016] Starting subtest: basic [206.982731] Starting dynamic subtest: flip [207.932992] Dynamic subtest flip: SUCCESS (0.951s) [207.939716] Starting dynamic subtest: modeset [211.461552] Dynamic subtest modeset: SUCCESS (3.528s) [211.462304] Subtest basic: SUCCESS (4.480s) [212.420916] [094/161] (820s left) kms_prop_blob (basic) [212.451628] Starting subtest: basic [212.452510] Subtest basic: SUCCESS (0.000s) [212.538898] [095/161] (820s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [214.534128] Starting subtest: basic-busy-flip-before-cursor-atomic [214.535503] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [214.674063] [096/161] (818s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [216.658770] Starting subtest: basic-busy-flip-before-cursor-legacy [216.660046] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [216.778942] [097/161] (816s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [218.768480] Starting subtest: basic-flip-after-cursor-atomic [219.989568] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.220s) [220.965967] [098/161] (812s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [222.957966] Starting subtest: basic-flip-after-cursor-legacy [224.180466] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.222s) [225.211134] [099/161] (807s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [227.206853] Starting subtest: basic-flip-after-cursor-varying-size [228.431150] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.222s) [229.443917] [100/161] (803s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [231.443168] Starting subtest: basic-flip-before-cursor-atomic [232.666731] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.223s) [233.699022] [101/161] (799s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [235.688695] Starting subtest: basic-flip-before-cursor-legacy [236.912914] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.222s) [237.912977] [102/161] (795s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [239.914011] Starting subtest: basic-flip-before-cursor-varying-size [241.133270] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.219s) [242.157616] [103/161] (791s left) kms_dsc (dsc-basic) [244.123953] Starting subtest: dsc-basic [244.131998] Subtest dsc-basic: SKIP (0.000s) [244.217771] [104/161] (789s left) kms_flip (basic-flip-vs-dpms) [246.181030] Starting subtest: basic-flip-vs-dpms [246.182605] Starting dynamic subtest: A-eDP1 [248.872912] Dynamic subtest A-eDP1: SUCCESS (2.690s) [248.879792] Starting dynamic subtest: B-eDP1 [251.129288] Dynamic subtest B-eDP1: SUCCESS (2.256s) [251.136209] Starting dynamic subtest: C-eDP1 [253.289125] Dynamic subtest C-eDP1: SUCCESS (2.159s) [253.295682] Starting dynamic subtest: D-eDP1 [255.442028] Dynamic subtest D-eDP1: SUCCESS (2.153s) [255.449958] Starting dynamic subtest: A-DP3 [256.220091] Dynamic subtest A-DP3: SUCCESS (0.776s) [256.232076] Starting dynamic subtest: B-DP3 [257.154871] Dynamic subtest B-DP3: SUCCESS (0.934s) [257.161502] Starting dynamic subtest: C-DP3 [258.091344] Dynamic subtest C-DP3: SUCCESS (0.935s) [258.103162] Starting dynamic subtest: D-DP3 [259.030711] Dynamic subtest D-DP3: SUCCESS (0.938s) [259.031530] Subtest basic-flip-vs-dpms: SUCCESS (12.850s) [259.542501] [105/161] (773s left) kms_flip (basic-flip-vs-modeset) [261.509064] Starting subtest: basic-flip-vs-modeset [261.510913] Starting dynamic subtest: A-eDP1 [264.144023] Dynamic subtest A-eDP1: SUCCESS (2.632s) [264.156121] Starting dynamic subtest: B-eDP1 [266.403351] Dynamic subtest B-eDP1: SUCCESS (2.259s) [266.410601] Starting dynamic subtest: C-eDP1 [268.678861] Dynamic subtest C-eDP1: SUCCESS (2.274s) [268.690962] Starting dynamic subtest: D-eDP1 [270.950647] Dynamic subtest D-eDP1: SUCCESS (2.272s) [270.967612] Starting dynamic subtest: A-DP3 [271.740802] Dynamic subtest A-DP3: SUCCESS (0.788s) [271.747811] Starting dynamic subtest: B-DP3 [272.477765] Dynamic subtest B-DP3: SUCCESS (0.737s) [272.484809] Starting dynamic subtest: C-DP3 [273.218772] Dynamic subtest C-DP3: SUCCESS (0.740s) [273.225688] Starting dynamic subtest: D-DP3 [273.951729] Dynamic subtest D-DP3: SUCCESS (0.732s) [273.952574] Subtest basic-flip-vs-modeset: SUCCESS (12.443s) [274.461209] [106/161] (758s left) kms_flip (basic-flip-vs-wf_vblank) [276.431380] Starting subtest: basic-flip-vs-wf_vblank [276.433280] Starting dynamic subtest: A-eDP1 [278.514132] Dynamic subtest A-eDP1: SUCCESS (2.080s) [278.524765] Starting dynamic subtest: B-eDP1 [280.540700] Dynamic subtest B-eDP1: SUCCESS (2.025s) [280.550785] Starting dynamic subtest: C-eDP1 [282.548257] Dynamic subtest C-eDP1: SUCCESS (2.006s) [282.560511] Starting dynamic subtest: D-eDP1 [284.579947] Dynamic subtest D-eDP1: SUCCESS (2.030s) [284.589910] Starting dynamic subtest: A-DP3 [285.911523] Dynamic subtest A-DP3: SUCCESS (1.328s) [285.926979] Starting dynamic subtest: B-DP3 [287.004794] Dynamic subtest B-DP3: SUCCESS (1.092s) [287.012154] Starting dynamic subtest: C-DP3 [288.097738] Dynamic subtest C-DP3: SUCCESS (1.092s) [288.106233] Starting dynamic subtest: D-DP3 [289.194107] Dynamic subtest D-DP3: SUCCESS (1.095s) [289.195174] Subtest basic-flip-vs-wf_vblank: SUCCESS (12.763s) [289.739422] [107/161] (743s left) kms_flip (basic-plain-flip) [291.706013] Starting subtest: basic-plain-flip [291.708527] Starting dynamic subtest: A-eDP1 [293.400647] Dynamic subtest A-eDP1: SUCCESS (1.691s) [293.418695] Starting dynamic subtest: B-eDP1 [295.109806] Dynamic subtest B-eDP1: SUCCESS (1.707s) [295.125859] Starting dynamic subtest: C-eDP1 [296.796433] Dynamic subtest C-eDP1: SUCCESS (1.683s) [296.806704] Starting dynamic subtest: D-eDP1 [298.496856] Dynamic subtest D-eDP1: SUCCESS (1.697s) [298.506931] Starting dynamic subtest: A-DP3 [299.565582] Dynamic subtest A-DP3: SUCCESS (1.064s) [299.577680] Starting dynamic subtest: B-DP3 [300.379496] Dynamic subtest B-DP3: SUCCESS (0.811s) [300.391789] Starting dynamic subtest: C-DP3 [301.196358] Dynamic subtest C-DP3: SUCCESS (0.813s) [301.208971] Starting dynamic subtest: D-DP3 [302.022045] Dynamic subtest D-DP3: SUCCESS (0.823s) [302.026660] Subtest basic-plain-flip: SUCCESS (10.320s) [302.600647] [108/161] (730s left) kms_force_connector_basic (force-connector-state) [302.648122] Starting subtest: force-connector-state [305.208232] Subtest force-connector-state: SUCCESS (2.560s) [308.293511] [109/161] (725s left) kms_force_connector_basic (force-edid) [308.350255] Starting subtest: force-edid [308.389031] Subtest force-edid: SUCCESS (0.039s) [310.517903] [110/161] (722s left) kms_force_connector_basic (force-load-detect) [310.560261] Starting subtest: force-load-detect [310.561775] Subtest force-load-detect: SKIP (0.000s) [311.670164] [111/161] (721s left) kms_force_connector_basic (prune-stale-modes) [311.714547] Starting subtest: prune-stale-modes [311.753024] Subtest prune-stale-modes: SUCCESS (0.039s) [313.879517] [112/161] (719s left) kms_frontbuffer_tracking (basic) [315.852248] Starting subtest: basic [320.275624] Subtest basic: SUCCESS (4.424s) [320.582196] [113/161] (712s left) kms_hdmi_inject (inject-audio) [320.998755] Starting subtest: inject-audio [321.119360] Subtest inject-audio: SUCCESS (0.121s) [322.934890] [114/161] (710s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [324.896857] Starting subtest: compare-crc-sanitycheck-xr24 [324.898942] Starting dynamic subtest: pipe-A-eDP-1 [325.774555] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.876s) [325.781525] Starting dynamic subtest: pipe-B-DP-3 [326.237499] Dynamic subtest pipe-B-DP-3: SUCCESS (0.462s) [326.245647] Starting dynamic subtest: pipe-C-DP-3 [326.712496] Dynamic subtest pipe-C-DP-3: SUCCESS (0.473s) [326.724552] Starting dynamic subtest: pipe-D-DP-3 [327.177622] Dynamic subtest pipe-D-DP-3: SUCCESS (0.465s) [327.178429] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.281s) [327.683263] [115/161] (705s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [329.648300] Starting subtest: compare-crc-sanitycheck-nv12 [329.648972] Starting dynamic subtest: pipe-A-eDP-1 [330.670242] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.021s) [330.678441] Starting dynamic subtest: pipe-B-DP-3 [331.282835] Dynamic subtest pipe-B-DP-3: SUCCESS (0.610s) [331.290022] Starting dynamic subtest: pipe-C-DP-3 [331.884673] Dynamic subtest pipe-C-DP-3: SUCCESS (0.601s) [331.892936] Starting dynamic subtest: pipe-D-DP-3 [332.491019] Dynamic subtest pipe-D-DP-3: SUCCESS (0.605s) [332.491724] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.843s) [332.983394] [116/161] (700s left) kms_pipe_crc_basic (hang-read-crc) [334.946646] Starting subtest: hang-read-crc [334.947276] Starting dynamic subtest: pipe-A-eDP-1 [337.379263] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.431s) [337.385864] Starting dynamic subtest: pipe-B-DP-3 [338.596731] Dynamic subtest pipe-B-DP-3: SUCCESS (1.216s) [338.603525] Starting dynamic subtest: pipe-C-DP-3 [339.816703] Dynamic subtest pipe-C-DP-3: SUCCESS (1.219s) [339.824313] Starting dynamic subtest: pipe-D-DP-3 [341.059744] Dynamic subtest pipe-D-DP-3: SUCCESS (1.241s) [341.060521] Subtest hang-read-crc: SUCCESS (6.113s) [341.512568] [117/161] (692s left) kms_pipe_crc_basic (nonblocking-crc) [343.477726] Starting subtest: nonblocking-crc [343.478372] Starting dynamic subtest: pipe-A-eDP-1 [344.528622] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.050s) [344.537582] Starting dynamic subtest: pipe-B-DP-3 [345.165844] Dynamic subtest pipe-B-DP-3: SUCCESS (0.635s) [345.174402] Starting dynamic subtest: pipe-C-DP-3 [345.818387] Dynamic subtest pipe-C-DP-3: SUCCESS (0.651s) [345.826447] Starting dynamic subtest: pipe-D-DP-3 [346.475118] Dynamic subtest pipe-D-DP-3: SUCCESS (0.655s) [346.475822] Subtest nonblocking-crc: SUCCESS (2.997s) [346.929833] [118/161] (686s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [348.895410] Starting subtest: nonblocking-crc-frame-sequence [348.896128] Starting dynamic subtest: pipe-A-eDP-1 [349.917039] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.021s) [349.930212] Starting dynamic subtest: pipe-B-DP-3 [350.549022] Dynamic subtest pipe-B-DP-3: SUCCESS (0.631s) [350.558870] Starting dynamic subtest: pipe-C-DP-3 [351.180767] Dynamic subtest pipe-C-DP-3: SUCCESS (0.629s) [351.187736] Starting dynamic subtest: pipe-D-DP-3 [351.837614] Dynamic subtest pipe-D-DP-3: SUCCESS (0.655s) [351.838423] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.941s) [352.301660] [119/161] (681s left) kms_pipe_crc_basic (read-crc) [354.263845] Starting subtest: read-crc [354.264632] Starting dynamic subtest: pipe-A-eDP-1 [355.234724] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.969s) [355.246907] Starting dynamic subtest: pipe-B-DP-3 [355.811987] Dynamic subtest pipe-B-DP-3: SUCCESS (0.576s) [355.820628] Starting dynamic subtest: pipe-C-DP-3 [356.381623] Dynamic subtest pipe-C-DP-3: SUCCESS (0.568s) [356.393730] Starting dynamic subtest: pipe-D-DP-3 [356.945541] Dynamic subtest pipe-D-DP-3: SUCCESS (0.562s) [356.946300] Subtest read-crc: SUCCESS (2.680s) [357.398537] [120/161] (676s left) kms_pipe_crc_basic (read-crc-frame-sequence) [359.372782] Starting subtest: read-crc-frame-sequence [359.373572] Starting dynamic subtest: pipe-A-eDP-1 [360.322678] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.950s) [360.329324] Starting dynamic subtest: pipe-B-DP-3 [360.885354] Dynamic subtest pipe-B-DP-3: SUCCESS (0.559s) [360.892305] Starting dynamic subtest: pipe-C-DP-3 [361.453678] Dynamic subtest pipe-C-DP-3: SUCCESS (0.566s) [361.460787] Starting dynamic subtest: pipe-D-DP-3 [362.034627] Dynamic subtest pipe-D-DP-3: SUCCESS (0.583s) [362.035399] Subtest read-crc-frame-sequence: SUCCESS (2.664s) [362.489241] [121/161] (671s left) kms_pm_backlight (basic-brightness) [364.454336] Starting subtest: basic-brightness [364.571136] Starting dynamic subtest: eDP-1 [364.886975] Dynamic subtest eDP-1: SUCCESS (0.316s) [364.887882] Subtest basic-brightness: SUCCESS (0.434s) [365.879894] [122/161] (667s left) kms_pm_rpm (basic-pci-d3-state) [370.368971] Starting subtest: basic-pci-d3-state [372.796887] Subtest basic-pci-d3-state: SUCCESS (2.428s) [374.046413] [123/161] (659s left) kms_pm_rpm (basic-rte) [374.076811] Starting subtest: basic-rte [380.963354] Subtest basic-rte: SUCCESS (6.887s) [384.526071] [124/161] (649s left) kms_psr (psr-primary-page-flip) [386.495253] Starting subtest: psr-primary-page-flip [386.496010] Starting dynamic subtest: eDP-1 [388.481022] Dynamic subtest eDP-1: SUCCESS (1.984s) [388.481818] Subtest psr-primary-page-flip: SUCCESS (1.985s) [389.491082] [125/161] (644s left) kms_psr (psr-cursor-plane-move) [391.455889] Starting subtest: psr-cursor-plane-move [391.456655] Starting dynamic subtest: eDP-1 [393.367280] Dynamic subtest eDP-1: SUCCESS (1.911s) [393.367939] Subtest psr-cursor-plane-move: SUCCESS (1.912s) [394.386339] [126/161] (639s left) kms_psr (psr-sprite-plane-onoff) [396.348264] Starting subtest: psr-sprite-plane-onoff [396.349093] Starting dynamic subtest: eDP-1 [398.330237] Dynamic subtest eDP-1: SUCCESS (1.981s) [398.330976] Subtest psr-sprite-plane-onoff: SUCCESS (1.982s) [399.286312] [127/161] (634s left) kms_psr (psr-primary-mmap-gtt) [401.252505] Starting subtest: psr-primary-mmap-gtt [401.253175] Starting dynamic subtest: eDP-1 [403.176677] Dynamic subtest eDP-1: SUCCESS (1.924s) [403.177463] Subtest psr-primary-mmap-gtt: SUCCESS (1.925s) [404.189429] [128/161] (629s left) kms_setmode (basic-clone-single-crtc) [404.219078] Starting subtest: basic-clone-single-crtc [404.661196] Subtest basic-clone-single-crtc: SKIP (0.440s) [405.473069] [129/161] (628s left) i915_pm_rps (basic-api) [405.510305] Starting subtest: basic-api [405.511998] Subtest basic-api: SKIP (0.000s) [405.589890] [130/161] (628s left) prime_self_import (basic-llseek-bad) [405.619071] Starting subtest: basic-llseek-bad [405.620726] Subtest basic-llseek-bad: SUCCESS (0.001s) [405.755643] [131/161] (628s left) prime_self_import (basic-llseek-size) [405.785570] Starting subtest: basic-llseek-size [405.786957] Subtest basic-llseek-size: SUCCESS (0.002s) [405.907355] [132/161] (628s left) prime_self_import (basic-with_fd_dup) [405.934596] Starting subtest: basic-with_fd_dup [405.937018] Subtest basic-with_fd_dup: SUCCESS (0.002s) [406.056373] [133/161] (628s left) prime_self_import (basic-with_one_bo) [406.085315] Starting subtest: basic-with_one_bo [406.086732] Subtest basic-with_one_bo: SUCCESS (0.002s) [406.161483] [134/161] (628s left) prime_self_import (basic-with_one_bo_two_files) [406.190946] Starting subtest: basic-with_one_bo_two_files [406.192346] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [406.324364] [135/161] (627s left) prime_self_import (basic-with_two_bos) [406.350957] Starting subtest: basic-with_two_bos [406.355069] Subtest basic-with_two_bos: SUCCESS (0.002s) [406.489617] [136/161] (627s left) prime_vgem (basic-fence-flip) [406.554684] Starting subtest: basic-fence-flip [408.867097] Subtest basic-fence-flip: SUCCESS (2.312s) [408.972896] [137/161] (625s left) prime_vgem (basic-fence-mmap) [409.038799] Starting subtest: basic-fence-mmap [409.056385] Subtest basic-fence-mmap: SUCCESS (0.018s) [409.178578] [138/161] (625s left) prime_vgem (basic-fence-read) [409.220967] Starting subtest: basic-fence-read [409.224837] Subtest basic-fence-read: SKIP (0.003s) [409.355929] [139/161] (624s left) prime_vgem (basic-gtt) [409.449637] Starting subtest: basic-gtt [409.457679] Subtest basic-gtt: SUCCESS (0.008s) [409.590073] [140/161] (624s left) prime_vgem (basic-read) [409.647648] Starting subtest: basic-read [409.651755] Subtest basic-read: SKIP (0.004s) [409.773357] [141/161] (624s left) prime_vgem (basic-write) [409.838642] Starting subtest: basic-write [409.842759] Subtest basic-write: SKIP (0.004s) [409.958256] [142/161] (624s left) vgem_basic (setversion) [410.000848] Starting subtest: setversion [410.002340] Subtest setversion: SUCCESS (0.000s) [410.073025] [143/161] (624s left) vgem_basic (create) [410.117246] Starting subtest: create [410.118112] Subtest create: SUCCESS (0.000s) [410.192849] [144/161] (624s left) vgem_basic (debugfs) [410.234043] Starting subtest: debugfs [410.234774] Subtest debugfs: SUCCESS (0.000s) [410.306178] [145/161] (624s left) vgem_basic (dmabuf-export) [410.351034] Starting subtest: dmabuf-export [410.361087] Subtest dmabuf-export: SUCCESS (0.010s) [410.455498] [146/161] (624s left) vgem_basic (dmabuf-fence) [410.500847] Starting subtest: dmabuf-fence [410.501734] Subtest dmabuf-fence: SUCCESS (0.000s) [410.571434] [147/161] (623s left) vgem_basic (dmabuf-fence-before) [410.617586] Starting subtest: dmabuf-fence-before [410.618394] Subtest dmabuf-fence-before: SUCCESS (0.000s) [410.689303] [148/161] (623s left) vgem_basic (dmabuf-mmap) [410.732494] Starting subtest: dmabuf-mmap [410.737873] Subtest dmabuf-mmap: SUCCESS (0.006s) [410.803327] [149/161] (623s left) vgem_basic (mmap) [410.849652] Starting subtest: mmap [410.853080] Subtest mmap: SUCCESS (0.004s) [410.920658] [150/161] (623s left) vgem_basic (second-client) [410.950442] Starting subtest: second-client [410.984687] Subtest second-client: SUCCESS (0.034s) [411.056584] [151/161] (623s left) vgem_basic (sysfs) [411.101388] Starting subtest: sysfs [411.102080] Subtest sysfs: SUCCESS (0.000s) [411.172174] [152/161] (623s left) core_hotunplug (unbind-rebind) [411.251291] Starting subtest: unbind-rebind [418.789043] Subtest unbind-rebind: SUCCESS (7.539s) [418.819327] [153/161] (615s left) vgem_basic (unload) [418.848854] Starting subtest: unload [448.049669] Subtest unload: SUCCESS (29.166s) [448.150792] [154/161] (586s left) i915_module_load (reload) [448.181915] Starting subtest: reload [455.629233] Subtest reload: SUCCESS (7.447s) [455.657209] [155/161] (579s left) gem_lmem_swapping (basic) [455.693894] Subtest basic: SKIP (0.000s) [455.736491] [156/161] (579s left) gem_lmem_swapping (parallel-random-engines) [455.769475] Subtest parallel-random-engines: SKIP (0.000s) [455.820324] [157/161] (579s left) gem_lmem_swapping (random-engines) [455.852621] Subtest random-engines: SKIP (0.000s) [455.910117] [158/161] (578s left) gem_lmem_swapping (verify-random) [455.943609] Subtest verify-random: SKIP (0.000s) [455.987255] [159/161] (578s left) i915_pm_rpm (module-reload) [461.245288] Starting subtest: module-reload [481.648067] Subtest module-reload: SUCCESS (20.392s) [481.669165] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [481.669950] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [481.673041] [160/161] (553s left) i915_selftest (live) [481.707172] Starting subtest: live [481.708172] Starting dynamic subtest: sanitycheck [483.735985] Dynamic subtest sanitycheck: SUCCESS (2.019s) [483.741573] Starting dynamic subtest: uncore [485.824022] Dynamic subtest uncore: SUCCESS (2.086s) [485.829865] Starting dynamic subtest: workarounds [488.955992] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 2315 [max: 8192] direct dependencies: 26288 [max: 524288] indirect dependencies: 211854 all direct dependencies: 542328 dependency chains: 39668 [max: 524288] dependency chain hlocks used: 168575 [max: 2621440] dependency chain hlocks lost: 0 in-hardirq chains: 292 in-softirq chains: 885 in-process chains: 38491 stack-trace entries: 329167 [max: 524288] number of stack traces: 14395 number of stack hash chains: 9590 combined max dependencies: 1402511624 hardirq-safe locks: 117 hardirq-unsafe locks: 1330 softirq-safe locks: 255 softirq-unsafe locks: 1224 irq-safe locks: 271 irq-unsafe locks: 1330 hardirq-read-safe locks: 5 hardirq-read-unsafe locks: 459 softirq-read-safe locks: 9 softirq-read-unsafe locks: 454 irq-read-safe locks: 9 irq-read-unsafe locks: 459 uncategorized locks: 388 unused locks: 2 max locking depth: 18 max bfs queue depth: 404 max lock class index: 2414 debug_locks: 0 zapped classes: 859 zapped lock chains: 21592 large chain blocks: 6