[82.334758] Initializing watchdogs [82.334798] /dev/watchdog0 [82.339601] [001/165] (960s left) i915_module_load (load) [82.414624] Starting subtest: load [89.532940] Subtest load: SUCCESS (7.118s) [89.552860] [002/165] (953s left) core_auth (basic-auth) [89.593083] Starting subtest: basic-auth [89.593758] Subtest basic-auth: SUCCESS (0.000s) [92.925210] [003/165] (949s left) debugfs_test (read_all_entries) [92.953939] Starting subtest: read_all_entries [93.158862] Subtest read_all_entries: SUCCESS (0.204s) [95.197943] [004/165] (947s left) debugfs_test (basic-hwmon) [95.234591] Starting subtest: basic-hwmon [95.236371] Subtest basic-hwmon: SKIP (0.000s) [97.258168] [005/165] (945s left) fbdev (eof) [97.296905] Starting subtest: eof [97.297735] Subtest eof: SUCCESS (0.000s) [97.358375] [006/165] (945s left) fbdev (info) [97.383956] Starting subtest: info [97.384882] Subtest info: SUCCESS (0.000s) [97.457864] [007/165] (945s left) fbdev (nullptr) [97.497117] Starting subtest: nullptr [97.498269] Subtest nullptr: SUCCESS (0.000s) [97.556975] [008/165] (945s left) fbdev (read) [97.605334] Starting subtest: read [100.213990] Subtest read: SUCCESS (2.600s) [100.271983] [009/165] (942s left) fbdev (write) [100.313917] Starting subtest: write [102.069626] Subtest write: SUCCESS (1.747s) [102.126734] [010/165] (940s left) gem_basic (bad-close) [102.151668] Starting subtest: bad-close [102.153525] Subtest bad-close: SUCCESS (0.000s) [102.217922] [011/165] (940s left) gem_basic (create-close) [102.245312] Starting subtest: create-close [102.246693] Subtest create-close: SUCCESS (0.000s) [102.336852] [012/165] (940s left) gem_basic (create-fd-close) [102.365555] Starting subtest: create-fd-close [102.367200] Subtest create-fd-close: SUCCESS (0.000s) [102.453640] [013/165] (940s left) gem_busy (busy@all-engines) [102.492612] Starting subtest: busy [102.493387] Starting dynamic subtest: all-engines [102.515040] Dynamic subtest all-engines: SUCCESS (0.022s) [102.515952] Subtest busy: SUCCESS (0.023s) [102.860530] [014/165] (940s left) gem_close_race (basic-process) [102.892262] Starting subtest: basic-process [102.930253] Subtest basic-process: SUCCESS (0.037s) [103.118295] [015/165] (939s left) gem_close_race (basic-threads) [103.150677] Starting subtest: basic-threads [104.379234] Subtest basic-threads: SUCCESS (1.228s) [104.565240] [016/165] (938s left) gem_ctx_create (basic) [104.597404] Starting subtest: basic [104.598132] Subtest basic: SUCCESS (0.000s) [104.786813] [017/165] (938s left) gem_ctx_create (basic-files) [104.821021] Starting subtest: basic-files [106.830836] Subtest basic-files: SUCCESS (2.010s) [107.019223] [018/165] (936s left) gem_ctx_exec (basic) [107.046963] Starting subtest: basic [107.048937] Subtest basic: SUCCESS (0.003s) [107.156208] [019/165] (935s left) gem_exec_basic (basic) [107.184223] Starting subtest: basic [107.184984] Starting dynamic subtest: rcs0-smem [107.185938] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [107.189648] Starting dynamic subtest: bcs0-smem [107.190411] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [107.193901] Starting dynamic subtest: vcs0-smem [107.194675] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [107.197951] Starting dynamic subtest: vcs1-smem [107.198782] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [107.202167] Starting dynamic subtest: vecs0-smem [107.202908] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [107.203652] Subtest basic: SUCCESS (0.002s) [107.382745] [020/165] (935s left) gem_exec_create (basic) [107.416679] Starting subtest: basic [107.417429] Starting dynamic subtest: smem [109.504704] Dynamic subtest smem: SUCCESS (2.087s) [109.506415] Subtest basic: SUCCESS (2.088s) [109.690224] [021/165] (933s left) gem_exec_fence (basic-busy) [109.847509] Starting subtest: basic-busy [109.848476] Starting dynamic subtest: rcs0 [109.891219] Dynamic subtest rcs0: SUCCESS (0.051s) [109.900694] Starting dynamic subtest: bcs0 [109.937484] Dynamic subtest bcs0: SUCCESS (0.046s) [109.944879] Starting dynamic subtest: vcs0 [109.989713] Dynamic subtest vcs0: SUCCESS (0.052s) [110.003284] Starting dynamic subtest: vcs1 [110.038262] Dynamic subtest vcs1: SUCCESS (0.048s) [110.049701] Starting dynamic subtest: vecs0 [110.087126] Dynamic subtest vecs0: SUCCESS (0.048s) [110.089161] Subtest basic-busy: SUCCESS (0.247s) [110.591210] [022/165] (932s left) gem_exec_fence (basic-wait) [110.754806] Starting subtest: basic-wait [110.756106] Starting dynamic subtest: rcs0 [110.822545] Dynamic subtest rcs0: SUCCESS (0.076s) [110.835729] Starting dynamic subtest: bcs0 [110.871847] Dynamic subtest bcs0: SUCCESS (0.049s) [110.883265] Starting dynamic subtest: vcs0 [110.918719] Dynamic subtest vcs0: SUCCESS (0.047s) [110.926841] Starting dynamic subtest: vcs1 [110.968691] Dynamic subtest vcs1: SUCCESS (0.050s) [110.978794] Starting dynamic subtest: vecs0 [111.025366] Dynamic subtest vecs0: SUCCESS (0.056s) [111.027257] Subtest basic-wait: SUCCESS (0.279s) [111.515889] [023/165] (931s left) gem_exec_fence (basic-await) [111.674870] Starting subtest: basic-await [111.675601] Starting dynamic subtest: rcs0 [111.737245] Dynamic subtest rcs0: SUCCESS (0.070s) [111.746507] Starting dynamic subtest: bcs0 [111.810919] Dynamic subtest bcs0: SUCCESS (0.073s) [111.820145] Starting dynamic subtest: vcs0 [111.886352] Dynamic subtest vcs0: SUCCESS (0.075s) [111.894026] Starting dynamic subtest: vcs1 [111.958049] Dynamic subtest vcs1: SUCCESS (0.071s) [111.965485] Starting dynamic subtest: vecs0 [112.031322] Dynamic subtest vecs0: SUCCESS (0.073s) [112.033568] Subtest basic-await: SUCCESS (0.365s) [112.510948] [024/165] (930s left) gem_exec_fence (nb-await) [112.670270] Starting subtest: nb-await [112.671188] Starting dynamic subtest: rcs0 [112.721221] Dynamic subtest rcs0: SUCCESS (0.058s) [112.735954] Starting dynamic subtest: bcs0 [112.787382] Dynamic subtest bcs0: SUCCESS (0.065s) [112.792838] Starting dynamic subtest: vcs0 [112.844661] Dynamic subtest vcs0: SUCCESS (0.057s) [112.857878] Starting dynamic subtest: vcs1 [112.908432] Dynamic subtest vcs1: SUCCESS (0.063s) [112.914164] Starting dynamic subtest: vecs0 [112.967639] Dynamic subtest vecs0: SUCCESS (0.059s) [112.970857] Subtest nb-await: SUCCESS (0.305s) [113.455783] [025/165] (929s left) gem_exec_gttfill (basic) [113.489264] Starting subtest: basic [115.585841] Subtest basic: SUCCESS (2.096s) [115.768203] [026/165] (927s left) gem_exec_parallel (engines) [115.845033] Starting subtest: engines [115.845705] Starting dynamic subtest: basic [117.143935] Dynamic subtest basic: SUCCESS (1.298s) [117.151149] Starting dynamic subtest: contexts [118.781218] Dynamic subtest contexts: SUCCESS (1.628s) [118.789308] Starting dynamic subtest: fds [120.605319] Dynamic subtest fds: SUCCESS (1.833s) [120.611899] Starting dynamic subtest: userptr [121.877822] Dynamic subtest userptr: SUCCESS (1.272s) [121.879831] Subtest engines: SUCCESS (6.032s) [122.069029] [027/165] (921s left) gem_exec_store (basic) [122.100291] Starting subtest: basic [122.184397] Subtest basic: SUCCESS (0.082s) [122.370473] [028/165] (920s left) gem_flink_basic (bad-flink) [122.402459] Starting subtest: bad-flink [122.403157] Subtest bad-flink: SUCCESS (0.000s) [122.470587] [029/165] (920s left) gem_flink_basic (bad-open) [122.499243] Starting subtest: bad-open [122.500000] Subtest bad-open: SUCCESS (0.000s) [122.571234] [030/165] (920s left) gem_flink_basic (basic) [122.595536] Starting subtest: basic [122.596228] Subtest basic: SUCCESS (0.000s) [122.670141] [031/165] (920s left) gem_flink_basic (double-flink) [122.701485] Starting subtest: double-flink [122.702199] Subtest double-flink: SUCCESS (0.000s) [122.789189] [032/165] (920s left) gem_flink_basic (flink-lifetime) [122.816074] Starting subtest: flink-lifetime [122.816814] Subtest flink-lifetime: SUCCESS (0.001s) [122.885853] [033/165] (920s left) gem_huc_copy (huc-copy) [122.914334] Starting subtest: huc-copy [122.915909] Subtest huc-copy: SUCCESS (0.002s) [123.021078] [034/165] (920s left) gem_linear_blits (basic) [123.096315] Starting subtest: basic [123.100062] Subtest basic: SUCCESS (0.004s) [123.235192] [035/165] (919s left) gem_mmap (basic) [123.302674] Starting subtest: basic [123.305757] Subtest basic: SUCCESS (0.001s) [123.369075] [036/165] (919s left) gem_mmap_gtt (basic) [123.396090] Starting subtest: basic [123.396746] Subtest basic: SUCCESS (0.000s) [123.454173] [037/165] (919s left) gem_render_linear_blits (basic) [123.483684] Starting subtest: basic [123.503830] Subtest basic: SUCCESS (0.020s) [123.571835] [038/165] (919s left) gem_render_tiled_blits (basic) [123.600065] Starting subtest: basic [123.621600] Subtest basic: SUCCESS (0.022s) [123.687337] [039/165] (919s left) gem_ringfill (basic-all) [124.009624] Starting subtest: basic-all [125.117107] Subtest basic-all: SUCCESS (1.109s) [125.231715] [040/165] (918s left) gem_softpin (allocator-basic) [125.261883] Starting subtest: allocator-basic [125.306474] Subtest allocator-basic: SUCCESS (0.045s) [125.417638] [041/165] (917s left) gem_softpin (allocator-basic-reserve) [125.447202] Starting subtest: allocator-basic-reserve [125.493017] Subtest allocator-basic-reserve: SUCCESS (0.046s) [125.602136] [042/165] (917s left) gem_softpin (safe-alignment) [125.634941] Starting subtest: safe-alignment [125.641397] Subtest safe-alignment: SUCCESS (0.006s) [125.748030] [043/165] (917s left) gem_sync (basic-all) [125.780483] Starting subtest: basic-all [128.084182] Subtest basic-all: SUCCESS (2.300s) [128.275123] [044/165] (915s left) gem_sync (basic-each) [128.306916] Starting subtest: basic-each [130.577921] Subtest basic-each: SUCCESS (2.270s) [130.770441] [045/165] (912s left) gem_tiled_blits (basic) [130.841308] Starting subtest: basic [130.850451] Subtest basic: SUCCESS (0.009s) [130.974985] [046/165] (912s left) gem_tiled_fence_blits (basic) [131.094587] Starting subtest: basic [131.113145] Subtest basic: SUCCESS (0.019s) [131.231916] [047/165] (912s left) gem_tiled_pread_basic [131.342842] [048/165] (912s left) gem_wait (busy@all-engines) [131.379784] Starting subtest: busy [131.380647] Starting dynamic subtest: all-engines [131.927743] Dynamic subtest all-engines: SUCCESS (0.548s) [131.929105] Subtest busy: SUCCESS (0.549s) [132.146382] [049/165] (911s left) gem_wait (wait@all-engines) [132.179302] Starting subtest: wait [132.180068] Starting dynamic subtest: all-engines [133.227726] Dynamic subtest all-engines: SUCCESS (1.047s) [133.229831] Subtest wait: SUCCESS (1.048s) [133.436389] [050/165] (909s left) i915_getparams_basic (basic-eu-total) [133.470097] Starting subtest: basic-eu-total [133.471385] Subtest basic-eu-total: SUCCESS (0.000s) [133.536136] [051/165] (909s left) i915_getparams_basic (basic-subslice-total) [133.560069] Starting subtest: basic-subslice-total [133.561411] Subtest basic-subslice-total: SUCCESS (0.000s) [133.629187] [052/165] (909s left) i915_hangman (error-state-basic) [133.658808] Starting subtest: error-state-basic [133.746050] Subtest error-state-basic: SUCCESS (0.087s) [133.825967] [053/165] (909s left) i915_pciid [133.926303] [054/165] (909s left) kms_addfb_basic (addfb25-4-tiled) [135.867068] Starting subtest: addfb25-4-tiled [135.867823] Subtest addfb25-4-tiled: SUCCESS (0.000s) [135.966544] [055/165] (907s left) kms_addfb_basic (addfb25-bad-modifier) [135.996872] Starting subtest: addfb25-bad-modifier [135.997958] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [137.998228] [056/165] (905s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [138.023636] Starting subtest: addfb25-framebuffer-vs-set-tiling [138.024399] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [140.022718] [057/165] (903s left) kms_addfb_basic (addfb25-modifier-no-flag) [140.049504] Starting subtest: addfb25-modifier-no-flag [140.050174] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [142.043627] [058/165] (901s left) kms_addfb_basic (addfb25-x-tiled-legacy) [142.072911] Starting subtest: addfb25-x-tiled-legacy [142.073809] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [144.073015] [059/165] (899s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [144.106197] Starting subtest: addfb25-x-tiled-mismatch-legacy [144.106976] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [146.107739] [060/165] (897s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [148.046289] Starting subtest: addfb25-yf-tiled-legacy [148.047200] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [148.132999] [061/165] (895s left) kms_addfb_basic (addfb25-y-tiled-legacy) [150.069698] Starting subtest: addfb25-y-tiled-legacy [150.070564] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [150.159830] [062/165] (893s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [152.096287] Starting subtest: addfb25-y-tiled-small-legacy [152.097198] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [152.179798] [063/165] (891s left) kms_addfb_basic (bad-pitch-0) [152.213199] Starting subtest: bad-pitch-0 [152.213981] Subtest bad-pitch-0: SUCCESS (0.000s) [154.215430] [064/165] (889s left) kms_addfb_basic (bad-pitch-1024) [154.241560] Starting subtest: bad-pitch-1024 [154.242383] Subtest bad-pitch-1024: SUCCESS (0.000s) [156.244235] [065/165] (887s left) kms_addfb_basic (bad-pitch-128) [156.270965] Starting subtest: bad-pitch-128 [156.271941] Subtest bad-pitch-128: SUCCESS (0.000s) [158.262356] [066/165] (885s left) kms_addfb_basic (bad-pitch-256) [158.298130] Starting subtest: bad-pitch-256 [158.298958] Subtest bad-pitch-256: SUCCESS (0.000s) [160.290434] [067/165] (883s left) kms_addfb_basic (bad-pitch-32) [160.321248] Starting subtest: bad-pitch-32 [160.322249] Subtest bad-pitch-32: SUCCESS (0.000s) [162.314446] [068/165] (881s left) kms_addfb_basic (bad-pitch-63) [162.343506] Starting subtest: bad-pitch-63 [162.344244] Subtest bad-pitch-63: SUCCESS (0.000s) [164.351981] [069/165] (879s left) kms_addfb_basic (bad-pitch-65536) [164.381199] Starting subtest: bad-pitch-65536 [164.381960] Subtest bad-pitch-65536: SUCCESS (0.000s) [166.377413] [070/165] (877s left) kms_addfb_basic (bad-pitch-999) [166.408073] Starting subtest: bad-pitch-999 [166.408766] Subtest bad-pitch-999: SUCCESS (0.000s) [168.399612] [071/165] (875s left) kms_addfb_basic (basic) [168.426649] Starting subtest: basic [168.427415] Subtest basic: SUCCESS (0.000s) [170.425337] [072/165] (873s left) kms_addfb_basic (basic-x-tiled-legacy) [170.456030] Starting subtest: basic-x-tiled-legacy [170.456796] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [172.442342] [073/165] (871s left) kms_addfb_basic (basic-y-tiled-legacy) [172.469926] Starting subtest: basic-y-tiled-legacy [172.470991] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [174.465579] [074/165] (869s left) kms_addfb_basic (bo-too-small) [176.401974] Starting subtest: bo-too-small [176.402822] Subtest bo-too-small: SUCCESS (0.000s) [176.500326] [075/165] (867s left) kms_addfb_basic (bo-too-small-due-to-tiling) [178.433711] Starting subtest: bo-too-small-due-to-tiling [178.434462] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [178.527285] [076/165] (865s left) kms_addfb_basic (clobberred-modifier) [178.556090] Starting subtest: clobberred-modifier [178.556948] Subtest clobberred-modifier: SUCCESS (0.000s) [180.548975] [077/165] (863s left) kms_addfb_basic (framebuffer-vs-set-tiling) [180.580948] Starting subtest: framebuffer-vs-set-tiling [180.581785] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [182.577474] [078/165] (861s left) kms_addfb_basic (invalid-get-prop) [182.607076] Starting subtest: invalid-get-prop [182.607844] Subtest invalid-get-prop: SUCCESS (0.000s) [184.603880] [079/165] (859s left) kms_addfb_basic (invalid-get-prop-any) [184.631120] Starting subtest: invalid-get-prop-any [184.632115] Subtest invalid-get-prop-any: SUCCESS (0.000s) [186.640757] [080/165] (857s left) kms_addfb_basic (invalid-set-prop) [186.670803] Starting subtest: invalid-set-prop [186.671680] Subtest invalid-set-prop: SUCCESS (0.000s) [188.668542] [081/165] (855s left) kms_addfb_basic (invalid-set-prop-any) [188.700053] Starting subtest: invalid-set-prop-any [188.700776] Subtest invalid-set-prop-any: SUCCESS (0.000s) [190.691500] [082/165] (853s left) kms_addfb_basic (no-handle) [190.725967] Starting subtest: no-handle [190.726850] Subtest no-handle: SUCCESS (0.000s) [192.716218] [083/165] (851s left) kms_addfb_basic (size-max) [194.650717] Starting subtest: size-max [194.651587] Subtest size-max: SUCCESS (0.000s) [194.731150] [084/165] (849s left) kms_addfb_basic (small-bo) [196.665936] Starting subtest: small-bo [196.666796] Subtest small-bo: SUCCESS (0.000s) [196.747474] [085/165] (847s left) kms_addfb_basic (tile-pitch-mismatch) [196.776843] Starting subtest: tile-pitch-mismatch [196.777602] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [198.771294] [086/165] (845s left) kms_addfb_basic (too-high) [200.705930] Starting subtest: too-high [200.706767] Subtest too-high: SUCCESS (0.000s) [200.792329] [087/165] (843s left) kms_addfb_basic (too-wide) [202.727301] Starting subtest: too-wide [202.728200] Subtest too-wide: SUCCESS (0.000s) [202.827143] [088/165] (840s left) kms_addfb_basic (unused-handle) [202.852892] Starting subtest: unused-handle [202.853821] Subtest unused-handle: SUCCESS (0.000s) [204.843897] [089/165] (838s left) kms_addfb_basic (unused-modifier) [204.872049] Starting subtest: unused-modifier [204.872980] Subtest unused-modifier: SUCCESS (0.000s) [206.871587] [090/165] (836s left) kms_addfb_basic (unused-offsets) [206.900128] Starting subtest: unused-offsets [206.900813] Subtest unused-offsets: SUCCESS (0.000s) [208.905287] [091/165] (834s left) kms_addfb_basic (unused-pitches) [208.933044] Starting subtest: unused-pitches [208.934046] Subtest unused-pitches: SUCCESS (0.000s) [210.931494] [092/165] (832s left) kms_busy (basic) [212.872108] Starting subtest: basic [212.872926] Starting dynamic subtest: flip [214.920673] Dynamic subtest flip: SUCCESS (2.049s) [214.927744] Starting dynamic subtest: modeset [218.920851] Dynamic subtest modeset: SUCCESS (3.999s) [218.921679] Subtest basic: SUCCESS (6.049s) [219.962727] [093/165] (823s left) kms_prop_blob (basic) [219.992294] Starting subtest: basic [219.992963] Subtest basic: SUCCESS (0.000s) [220.059579] [094/165] (823s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [222.021513] Starting subtest: basic-busy-flip-before-cursor-atomic [222.023199] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [222.138254] [095/165] (821s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [224.098214] Starting subtest: basic-busy-flip-before-cursor-legacy [224.099787] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [224.202432] [096/165] (819s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [226.170646] Starting subtest: basic-flip-after-cursor-atomic [228.535371] Subtest basic-flip-after-cursor-atomic: SUCCESS (2.365s) [229.621886] [097/165] (814s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [231.581451] Starting subtest: basic-flip-after-cursor-legacy [233.913104] Subtest basic-flip-after-cursor-legacy: SUCCESS (2.331s) [234.987944] [098/165] (808s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [236.953182] Starting subtest: basic-flip-after-cursor-varying-size [239.289147] Subtest basic-flip-after-cursor-varying-size: SUCCESS (2.336s) [240.375137] [099/165] (803s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [242.334275] Starting subtest: basic-flip-before-cursor-atomic [244.667276] Subtest basic-flip-before-cursor-atomic: SUCCESS (2.333s) [245.746240] [100/165] (798s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [247.705074] Starting subtest: basic-flip-before-cursor-legacy [250.038712] Subtest basic-flip-before-cursor-legacy: SUCCESS (2.334s) [251.123427] [101/165] (792s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [253.083011] Starting subtest: basic-flip-before-cursor-varying-size [255.408528] Subtest basic-flip-before-cursor-varying-size: SUCCESS (2.325s) [256.504325] [102/165] (787s left) kms_dsc (dsc-basic) [258.439073] Starting subtest: dsc-basic [258.441224] Subtest dsc-basic: SKIP (0.000s) [258.514959] [103/165] (785s left) kms_flip (basic-flip-vs-dpms) [259.514886] Starting subtest: basic-flip-vs-dpms [259.516811] Starting dynamic subtest: A-eDP1 [262.252602] Dynamic subtest A-eDP1: SUCCESS (2.736s) [262.257659] Starting dynamic subtest: B-eDP1 [264.619071] Dynamic subtest B-eDP1: SUCCESS (2.366s) [264.623875] Starting dynamic subtest: C-eDP1 [266.987462] Dynamic subtest C-eDP1: SUCCESS (2.368s) [266.992221] Starting dynamic subtest: D-eDP1 [269.352081] Dynamic subtest D-eDP1: SUCCESS (2.364s) [269.357652] Starting dynamic subtest: A-DP3 [270.189776] Dynamic subtest A-DP3: SUCCESS (0.835s) [270.194738] Starting dynamic subtest: B-DP3 [270.971800] Dynamic subtest B-DP3: SUCCESS (0.783s) [270.976889] Starting dynamic subtest: C-DP3 [271.757918] Dynamic subtest C-DP3: SUCCESS (0.785s) [271.762984] Starting dynamic subtest: D-DP3 [272.534062] Dynamic subtest D-DP3: SUCCESS (0.775s) [272.535053] Subtest basic-flip-vs-dpms: SUCCESS (13.021s) [273.045529] [104/165] (770s left) kms_flip (basic-flip-vs-modeset) [274.047049] Starting subtest: basic-flip-vs-modeset [274.049493] Starting dynamic subtest: A-eDP1 [276.776254] Dynamic subtest A-eDP1: SUCCESS (2.726s) [276.781242] Starting dynamic subtest: B-eDP1 [279.139402] Dynamic subtest B-eDP1: SUCCESS (2.363s) [279.144523] Starting dynamic subtest: C-eDP1 [281.507321] Dynamic subtest C-eDP1: SUCCESS (2.367s) [281.511826] Starting dynamic subtest: D-eDP1 [283.881089] Dynamic subtest D-eDP1: SUCCESS (2.372s) [283.888130] Starting dynamic subtest: A-DP3 [284.709750] Dynamic subtest A-DP3: SUCCESS (0.827s) [284.715543] Starting dynamic subtest: B-DP3 [285.490886] Dynamic subtest B-DP3: SUCCESS (0.780s) [285.497115] Starting dynamic subtest: C-DP3 [286.270128] Dynamic subtest C-DP3: SUCCESS (0.779s) [286.275087] Starting dynamic subtest: D-DP3 [287.043791] Dynamic subtest D-DP3: SUCCESS (0.773s) [287.044630] Subtest basic-flip-vs-modeset: SUCCESS (12.997s) [287.546502] [105/165] (756s left) kms_flip (basic-flip-vs-wf_vblank) [288.552895] Starting subtest: basic-flip-vs-wf_vblank [288.555562] Starting dynamic subtest: A-eDP1 [290.598558] Dynamic subtest A-eDP1: SUCCESS (2.041s) [290.609627] Starting dynamic subtest: B-eDP1 [292.671182] Dynamic subtest B-eDP1: SUCCESS (2.069s) [292.684684] Starting dynamic subtest: C-eDP1 [294.702282] Dynamic subtest C-eDP1: SUCCESS (2.026s) [294.711443] Starting dynamic subtest: D-eDP1 [296.748061] Dynamic subtest D-eDP1: SUCCESS (2.044s) [296.756977] Starting dynamic subtest: A-DP3 [298.085246] Dynamic subtest A-DP3: SUCCESS (1.333s) [298.095085] Starting dynamic subtest: B-DP3 [299.167970] Dynamic subtest B-DP3: SUCCESS (1.077s) [299.176786] Starting dynamic subtest: C-DP3 [300.245779] Dynamic subtest C-DP3: SUCCESS (1.074s) [300.254034] Starting dynamic subtest: D-DP3 [301.322072] Dynamic subtest D-DP3: SUCCESS (1.074s) [301.323726] Subtest basic-flip-vs-wf_vblank: SUCCESS (12.768s) [301.845550] [106/165] (742s left) kms_flip (basic-plain-flip) [302.850346] Starting subtest: basic-plain-flip [302.851899] Starting dynamic subtest: A-eDP1 [304.608314] Dynamic subtest A-eDP1: SUCCESS (1.754s) [304.621108] Starting dynamic subtest: B-eDP1 [306.399450] Dynamic subtest B-eDP1: SUCCESS (1.788s) [306.412235] Starting dynamic subtest: C-eDP1 [308.176411] Dynamic subtest C-eDP1: SUCCESS (1.773s) [308.185847] Starting dynamic subtest: D-eDP1 [309.904178] Dynamic subtest D-eDP1: SUCCESS (1.726s) [309.914284] Starting dynamic subtest: A-DP3 [310.962547] Dynamic subtest A-DP3: SUCCESS (1.052s) [310.970379] Starting dynamic subtest: B-DP3 [311.758526] Dynamic subtest B-DP3: SUCCESS (0.793s) [311.770249] Starting dynamic subtest: C-DP3 [312.551922] Dynamic subtest C-DP3: SUCCESS (0.792s) [312.556838] Starting dynamic subtest: D-DP3 [313.352427] Dynamic subtest D-DP3: SUCCESS (0.797s) [313.353606] Subtest basic-plain-flip: SUCCESS (10.503s) [313.879595] [107/165] (730s left) kms_force_connector_basic (force-connector-state) [313.916857] Starting subtest: force-connector-state [316.584308] Subtest force-connector-state: SUCCESS (2.666s) [319.480527] [108/165] (724s left) kms_force_connector_basic (force-edid) [319.508183] Starting subtest: force-edid [319.538597] Subtest force-edid: SUCCESS (0.030s) [321.592616] [109/165] (722s left) kms_force_connector_basic (force-load-detect) [321.619433] Starting subtest: force-load-detect [321.621051] Subtest force-load-detect: SKIP (0.000s) [322.677979] [110/165] (721s left) kms_force_connector_basic (prune-stale-modes) [322.713075] Starting subtest: prune-stale-modes [322.742120] Subtest prune-stale-modes: SUCCESS (0.029s) [324.797154] [111/165] (719s left) kms_frontbuffer_tracking (basic) [326.746308] Starting subtest: basic [331.621415] Subtest basic: SUCCESS (4.877s) [333.035722] [112/165] (711s left) kms_hdmi_inject (inject-audio) [333.617028] Starting subtest: inject-audio [333.711064] Subtest inject-audio: SUCCESS (0.094s) [335.404946] [113/165] (708s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [337.340460] Starting subtest: compare-crc-sanitycheck-xr24 [337.341486] Starting dynamic subtest: pipe-A-eDP-1 [339.254788] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.914s) [339.261441] Starting dynamic subtest: pipe-B-DP-3 [339.710616] Dynamic subtest pipe-B-DP-3: SUCCESS (0.455s) [339.715489] Starting dynamic subtest: pipe-C-DP-3 [340.173467] Dynamic subtest pipe-C-DP-3: SUCCESS (0.462s) [340.179309] Starting dynamic subtest: pipe-D-DP-3 [340.632482] Dynamic subtest pipe-D-DP-3: SUCCESS (0.458s) [340.633152] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.293s) [341.112104] [114/165] (702s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [343.046675] Starting subtest: compare-crc-sanitycheck-nv12 [343.047451] Starting dynamic subtest: pipe-A-eDP-1 [345.138981] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.091s) [345.143906] Starting dynamic subtest: pipe-B-DP-3 [345.750516] Dynamic subtest pipe-B-DP-3: SUCCESS (0.609s) [345.755768] Starting dynamic subtest: pipe-C-DP-3 [346.346853] Dynamic subtest pipe-C-DP-3: SUCCESS (0.596s) [346.351844] Starting dynamic subtest: pipe-D-DP-3 [346.953139] Dynamic subtest pipe-D-DP-3: SUCCESS (0.604s) [346.954117] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.906s) [347.427792] [115/165] (696s left) kms_pipe_crc_basic (hang-read-crc) [349.368220] Starting subtest: hang-read-crc [349.368939] Starting dynamic subtest: pipe-A-eDP-1 [352.947714] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.579s) [352.956100] Starting dynamic subtest: pipe-B-DP-3 [354.166404] Dynamic subtest pipe-B-DP-3: SUCCESS (1.217s) [354.172486] Starting dynamic subtest: pipe-C-DP-3 [355.395996] Dynamic subtest pipe-C-DP-3: SUCCESS (1.228s) [355.401108] Starting dynamic subtest: pipe-D-DP-3 [356.657842] Dynamic subtest pipe-D-DP-3: SUCCESS (1.261s) [356.658460] Subtest hang-read-crc: SUCCESS (7.290s) [357.114566] [116/165] (686s left) kms_pipe_crc_basic (nonblocking-crc) [359.041580] Starting subtest: nonblocking-crc [359.043644] Starting dynamic subtest: pipe-A-eDP-1 [361.126922] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.084s) [361.131624] Starting dynamic subtest: pipe-B-DP-3 [361.746414] Dynamic subtest pipe-B-DP-3: SUCCESS (0.618s) [361.751221] Starting dynamic subtest: pipe-C-DP-3 [362.365650] Dynamic subtest pipe-C-DP-3: SUCCESS (0.617s) [362.370784] Starting dynamic subtest: pipe-D-DP-3 [362.986898] Dynamic subtest pipe-D-DP-3: SUCCESS (0.621s) [362.987849] Subtest nonblocking-crc: SUCCESS (3.945s) [363.441525] [117/165] (680s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [365.376476] Starting subtest: nonblocking-crc-frame-sequence [365.377375] Starting dynamic subtest: pipe-A-eDP-1 [367.401706] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.025s) [367.406826] Starting dynamic subtest: pipe-B-DP-3 [368.035453] Dynamic subtest pipe-B-DP-3: SUCCESS (0.633s) [368.040501] Starting dynamic subtest: pipe-C-DP-3 [368.651910] Dynamic subtest pipe-C-DP-3: SUCCESS (0.616s) [368.658174] Starting dynamic subtest: pipe-D-DP-3 [369.296198] Dynamic subtest pipe-D-DP-3: SUCCESS (0.643s) [369.296877] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.921s) [369.749113] [118/165] (674s left) kms_pipe_crc_basic (read-crc) [371.686664] Starting subtest: read-crc [371.687795] Starting dynamic subtest: pipe-A-eDP-1 [373.709292] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.024s) [373.715826] Starting dynamic subtest: pipe-B-DP-3 [374.263708] Dynamic subtest pipe-B-DP-3: SUCCESS (0.553s) [374.270051] Starting dynamic subtest: pipe-C-DP-3 [374.821511] Dynamic subtest pipe-C-DP-3: SUCCESS (0.556s) [374.826497] Starting dynamic subtest: pipe-D-DP-3 [375.381299] Dynamic subtest pipe-D-DP-3: SUCCESS (0.559s) [375.382150] Subtest read-crc: SUCCESS (3.696s) [375.825034] [119/165] (668s left) kms_pipe_crc_basic (read-crc-frame-sequence) [377.762624] Starting subtest: read-crc-frame-sequence [377.763636] Starting dynamic subtest: pipe-A-eDP-1 [379.785264] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.023s) [379.791164] Starting dynamic subtest: pipe-B-DP-3 [380.342530] Dynamic subtest pipe-B-DP-3: SUCCESS (0.555s) [380.349356] Starting dynamic subtest: pipe-C-DP-3 [380.918206] Dynamic subtest pipe-C-DP-3: SUCCESS (0.575s) [380.923319] Starting dynamic subtest: pipe-D-DP-3 [381.494533] Dynamic subtest pipe-D-DP-3: SUCCESS (0.573s) [381.495275] Subtest read-crc-frame-sequence: SUCCESS (3.731s) [381.959707] [120/165] (662s left) kms_pm_backlight (basic-brightness) [383.894596] Starting subtest: basic-brightness [385.084398] Starting dynamic subtest: eDP-1 [385.377817] Dynamic subtest eDP-1: SUCCESS (0.294s) [385.378443] Subtest basic-brightness: SUCCESS (1.483s) [386.406490] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1816 [max: 8192] direct dependencies: 18180 [max: 32768] indirect dependencies: 140324 all direct dependencies: 388165 dependency chains: 27486 [max: 131072] dependency chain hlocks used: 120458 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 284 in-softirq chains: 627 in-process chains: 26575 stack-trace entries: 171933 [max: 1048576] number of stack traces: 8670 number of stack hash chains: 6705 combined max dependencies: 461605184 hardirq-safe locks: 104 hardirq-unsafe locks: 1085 softirq-safe locks: 222 softirq-unsafe locks: 993 irq-safe locks: 237 irq-unsafe locks: 1085 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 328 softirq-read-safe locks: 7 softirq-read-unsafe locks: 323 irq-read-safe locks: 7 irq-read-unsafe locks: 328 uncategorized locks: 283 unused locks: 1 max locking depth: 16 max bfs queue depth: 407 max lock class index: 1815 chain lookup misses: 27926 chain lookup hits: 458882833 cyclic checks: 28009 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4883 find-mask backwards checks: 2731 hardirq on events: 234063482 hardirq off events: 234063466 redundant hardirq ons: 38 redundant hardirq offs: 26 softirq on events: 1757228 softirq off events: 1757228 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 110 large chain blocks: 1 [386.407975] Closing watchdogs Done.