[78.995433] Initializing watchdogs [78.995487] /dev/watchdog0 [78.999514] [001/170] (960s left) i915_module_load (load) [79.039210] Starting subtest: load [92.227876] Subtest load: SUCCESS (13.188s) [92.242932] [002/170] (947s left) core_auth (basic-auth) [92.292194] Starting subtest: basic-auth [92.292922] Subtest basic-auth: SUCCESS (0.000s) [94.283363] [003/170] (945s left) debugfs_test (read_all_entries) [94.324660] Starting subtest: read_all_entries [94.632280] Subtest read_all_entries: SUCCESS (0.308s) [98.567794] [004/170] (940s left) debugfs_test (basic-hwmon) [98.606961] Starting subtest: basic-hwmon [98.608486] Subtest basic-hwmon: SKIP (0.000s) [102.455630] [005/170] (937s left) fbdev (eof) [102.506099] Starting subtest: eof [102.507020] Subtest eof: SUCCESS (0.000s) [102.591159] [006/170] (936s left) fbdev (info) [102.628177] Starting subtest: info [102.628882] Subtest info: SUCCESS (0.000s) [102.723961] [007/170] (936s left) fbdev (nullptr) [102.772879] Starting subtest: nullptr [102.773860] Subtest nullptr: SUCCESS (0.000s) [102.855931] [008/170] (936s left) fbdev (read) [102.905996] Starting subtest: read [110.877258] Subtest read: SUCCESS (7.961s) [110.966459] [009/170] (928s left) fbdev (write) [111.012817] Starting subtest: write [116.530154] Subtest write: SUCCESS (5.517s) [116.632213] [010/170] (922s left) gem_basic (bad-close) [116.668490] Starting subtest: bad-close [116.670184] Subtest bad-close: SUCCESS (0.000s) [116.745394] [011/170] (922s left) gem_basic (create-close) [116.780381] Starting subtest: create-close [116.782147] Subtest create-close: SUCCESS (0.000s) [116.892929] [012/170] (922s left) gem_basic (create-fd-close) [116.928516] Starting subtest: create-fd-close [116.929864] Subtest create-fd-close: SUCCESS (0.000s) [117.012322] [013/170] (922s left) gem_busy (busy@all-engines) [117.054916] Starting subtest: busy [117.055789] Starting dynamic subtest: all-engines [117.076523] Dynamic subtest all-engines: SUCCESS (0.021s) [117.077647] Subtest busy: SUCCESS (0.022s) [117.416124] [014/170] (922s left) gem_close_race (basic-process) [117.457765] Starting subtest: basic-process [117.493893] Subtest basic-process: SUCCESS (0.036s) [117.694532] [015/170] (921s left) gem_close_race (basic-threads) [117.735664] Starting subtest: basic-threads [118.945399] Subtest basic-threads: SUCCESS (1.209s) [119.143446] [016/170] (920s left) gem_ctx_create (basic) [119.184700] Starting subtest: basic [119.185612] Subtest basic: SUCCESS (0.000s) [119.385847] [017/170] (920s left) gem_ctx_create (basic-files) [119.426796] Starting subtest: basic-files [121.434448] Subtest basic-files: SUCCESS (2.008s) [121.831501] [018/170] (917s left) gem_ctx_exec (basic) [121.870296] Starting subtest: basic [121.872174] Subtest basic: SUCCESS (0.003s) [121.979747] [019/170] (917s left) gem_exec_basic (basic) [122.020328] Starting subtest: basic [122.021214] Starting dynamic subtest: rcs0-smem [122.022081] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [122.027127] Starting dynamic subtest: bcs0-smem [122.027940] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [122.033370] Starting dynamic subtest: vcs0-smem [122.034279] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [122.039457] Starting dynamic subtest: vcs1-smem [122.040271] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [122.045597] Starting dynamic subtest: vecs0-smem [122.046468] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [122.047376] Subtest basic: SUCCESS (0.002s) [122.229316] [020/170] (917s left) gem_exec_create (basic) [122.270690] Starting subtest: basic [122.271721] Starting dynamic subtest: smem [124.356130] Dynamic subtest smem: SUCCESS (2.084s) [124.358156] Subtest basic: SUCCESS (2.085s) [124.561456] [021/170] (915s left) gem_exec_fence (basic-busy) [124.730850] Starting subtest: basic-busy [124.732309] Starting dynamic subtest: rcs0 [124.775029] Dynamic subtest rcs0: SUCCESS (0.053s) [124.782964] Starting dynamic subtest: bcs0 [124.821946] Dynamic subtest bcs0: SUCCESS (0.047s) [124.830690] Starting dynamic subtest: vcs0 [124.868780] Dynamic subtest vcs0: SUCCESS (0.047s) [124.880743] Starting dynamic subtest: vcs1 [124.919746] Dynamic subtest vcs1: SUCCESS (0.049s) [124.929183] Starting dynamic subtest: vecs0 [124.965841] Dynamic subtest vecs0: SUCCESS (0.047s) [124.967330] Subtest basic-busy: SUCCESS (0.244s) [125.495078] [022/170] (914s left) gem_exec_fence (basic-wait) [125.662872] Starting subtest: basic-wait [125.664071] Starting dynamic subtest: rcs0 [125.721502] Dynamic subtest rcs0: SUCCESS (0.065s) [125.732445] Starting dynamic subtest: bcs0 [125.769499] Dynamic subtest bcs0: SUCCESS (0.048s) [125.777244] Starting dynamic subtest: vcs0 [125.817888] Dynamic subtest vcs0: SUCCESS (0.048s) [125.827464] Starting dynamic subtest: vcs1 [125.864998] Dynamic subtest vcs1: SUCCESS (0.047s) [125.877955] Starting dynamic subtest: vecs0 [125.912570] Dynamic subtest vecs0: SUCCESS (0.048s) [125.914564] Subtest basic-wait: SUCCESS (0.258s) [126.411590] [023/170] (913s left) gem_exec_fence (basic-await) [126.577024] Starting subtest: basic-await [126.577977] Starting dynamic subtest: rcs0 [126.640670] Dynamic subtest rcs0: SUCCESS (0.071s) [126.649157] Starting dynamic subtest: bcs0 [126.712143] Dynamic subtest bcs0: SUCCESS (0.071s) [126.720914] Starting dynamic subtest: vcs0 [126.785409] Dynamic subtest vcs0: SUCCESS (0.072s) [126.793837] Starting dynamic subtest: vcs1 [126.857466] Dynamic subtest vcs1: SUCCESS (0.072s) [126.866829] Starting dynamic subtest: vecs0 [126.930248] Dynamic subtest vecs0: SUCCESS (0.073s) [126.932098] Subtest basic-await: SUCCESS (0.361s) [127.433415] [024/170] (912s left) gem_exec_fence (nb-await) [127.598344] Starting subtest: nb-await [127.599139] Starting dynamic subtest: rcs0 [127.649973] Dynamic subtest rcs0: SUCCESS (0.059s) [127.662087] Starting dynamic subtest: bcs0 [127.713892] Dynamic subtest bcs0: SUCCESS (0.063s) [127.723736] Starting dynamic subtest: vcs0 [127.773756] Dynamic subtest vcs0: SUCCESS (0.060s) [127.780835] Starting dynamic subtest: vcs1 [127.835336] Dynamic subtest vcs1: SUCCESS (0.062s) [127.847229] Starting dynamic subtest: vecs0 [127.898280] Dynamic subtest vecs0: SUCCESS (0.062s) [127.900721] Subtest nb-await: SUCCESS (0.308s) [128.388697] [025/170] (911s left) gem_exec_gttfill (basic) [128.431897] Starting subtest: basic [131.154740] Subtest basic: SUCCESS (2.722s) [131.352312] [026/170] (908s left) gem_exec_parallel (engines) [131.432533] Starting subtest: engines [131.433356] Starting dynamic subtest: basic [132.854036] Dynamic subtest basic: SUCCESS (1.421s) [132.862263] Starting dynamic subtest: contexts [134.594928] Dynamic subtest contexts: SUCCESS (1.732s) [134.601189] Starting dynamic subtest: fds [136.433913] Dynamic subtest fds: SUCCESS (1.840s) [136.437976] Starting dynamic subtest: userptr [137.804079] Dynamic subtest userptr: SUCCESS (1.378s) [137.805453] Subtest engines: SUCCESS (6.371s) [138.007641] [027/170] (901s left) gem_exec_store (basic) [138.049222] Starting subtest: basic [138.126447] Subtest basic: SUCCESS (0.075s) [138.329174] [028/170] (901s left) gem_flink_basic (bad-flink) [138.366244] Starting subtest: bad-flink [138.366942] Subtest bad-flink: SUCCESS (0.000s) [138.442448] [029/170] (901s left) gem_flink_basic (bad-open) [138.478579] Starting subtest: bad-open [138.479645] Subtest bad-open: SUCCESS (0.000s) [138.560199] [030/170] (901s left) gem_flink_basic (basic) [138.597053] Starting subtest: basic [138.597889] Subtest basic: SUCCESS (0.000s) [138.695802] [031/170] (901s left) gem_flink_basic (double-flink) [138.731296] Starting subtest: double-flink [138.732169] Subtest double-flink: SUCCESS (0.000s) [138.828986] [032/170] (900s left) gem_flink_basic (flink-lifetime) [138.865259] Starting subtest: flink-lifetime [138.866134] Subtest flink-lifetime: SUCCESS (0.001s) [138.962270] [033/170] (900s left) gem_huc_copy (huc-copy) [139.003276] Starting subtest: huc-copy [139.004907] Subtest huc-copy: SUCCESS (0.002s) [139.110076] [034/170] (900s left) gem_linear_blits (basic) [139.210782] Starting subtest: basic [139.214858] Subtest basic: SUCCESS (0.004s) [139.349713] [035/170] (900s left) gem_mmap (basic) [139.424256] Starting subtest: basic [139.427263] Subtest basic: SUCCESS (0.000s) [139.540112] [036/170] (900s left) gem_mmap_gtt (basic) [139.576083] Starting subtest: basic [139.576914] Subtest basic: SUCCESS (0.000s) [139.657443] [037/170] (900s left) gem_render_linear_blits (basic) [139.699475] Starting subtest: basic [139.717524] Subtest basic: SUCCESS (0.018s) [139.807195] [038/170] (900s left) gem_render_tiled_blits (basic) [139.845838] Starting subtest: basic [139.871879] Subtest basic: SUCCESS (0.026s) [139.956855] [039/170] (899s left) gem_ringfill (basic-all) [140.287842] Starting subtest: basic-all [141.421515] Subtest basic-all: SUCCESS (1.128s) [141.551810] [040/170] (898s left) gem_softpin (allocator-basic) [141.592263] Starting subtest: allocator-basic [141.638931] Subtest allocator-basic: SUCCESS (0.047s) [141.756241] [041/170] (898s left) gem_softpin (allocator-basic-reserve) [141.793891] Starting subtest: allocator-basic-reserve [141.837348] Subtest allocator-basic-reserve: SUCCESS (0.044s) [141.976926] [042/170] (897s left) gem_softpin (safe-alignment) [142.015182] Starting subtest: safe-alignment [142.021213] Subtest safe-alignment: SUCCESS (0.006s) [142.138081] [043/170] (897s left) gem_sync (basic-all) [142.182354] Starting subtest: basic-all [144.576126] Subtest basic-all: SUCCESS (2.393s) [144.781732] [044/170] (895s left) gem_sync (basic-each) [144.824789] Starting subtest: basic-each [147.070928] Subtest basic-each: SUCCESS (2.247s) [147.272323] [045/170] (892s left) gem_tiled_blits (basic) [147.356853] Starting subtest: basic [147.365464] Subtest basic: SUCCESS (0.009s) [147.512677] [046/170] (892s left) gem_tiled_fence_blits (basic) [147.640129] Starting subtest: basic [147.726083] Subtest basic: SUCCESS (0.086s) [147.859670] [047/170] (892s left) gem_tiled_pread_basic [147.988646] [048/170] (892s left) gem_wait (busy@all-engines) [148.032993] Starting subtest: busy [148.033816] Starting dynamic subtest: all-engines [148.583736] Dynamic subtest all-engines: SUCCESS (0.549s) [148.585539] Subtest busy: SUCCESS (0.550s) [148.801159] [049/170] (891s left) gem_wait (wait@all-engines) [148.844088] Starting subtest: wait [148.845032] Starting dynamic subtest: all-engines [149.893542] Dynamic subtest all-engines: SUCCESS (1.048s) [149.895625] Subtest wait: SUCCESS (1.048s) [150.116206] [050/170] (889s left) i915_getparams_basic (basic-eu-total) [150.154633] Starting subtest: basic-eu-total [150.156993] Subtest basic-eu-total: SUCCESS (0.000s) [150.228275] [051/170] (889s left) i915_getparams_basic (basic-subslice-total) [150.264229] Starting subtest: basic-subslice-total [150.265993] Subtest basic-subslice-total: SUCCESS (0.000s) [150.344011] [052/170] (889s left) i915_hangman (error-state-basic) [150.384627] Starting subtest: error-state-basic [150.554413] Subtest error-state-basic: SUCCESS (0.170s) [150.652248] [053/170] (889s left) i915_pciid [150.767628] [054/170] (889s left) kms_addfb_basic (addfb25-bad-modifier) [150.806794] Starting subtest: addfb25-bad-modifier [150.807715] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [154.678645] [055/170] (885s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [154.717117] Starting subtest: addfb25-framebuffer-vs-set-tiling [154.718105] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [158.579759] [056/170] (881s left) kms_addfb_basic (addfb25-modifier-no-flag) [158.615699] Starting subtest: addfb25-modifier-no-flag [158.616723] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [162.479532] [057/170] (877s left) kms_addfb_basic (addfb25-x-tiled-legacy) [162.515536] Starting subtest: addfb25-x-tiled-legacy [162.516439] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [166.383555] [058/170] (873s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [166.420483] Starting subtest: addfb25-x-tiled-mismatch-legacy [166.421376] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [170.284012] [059/170] (869s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [174.085266] Starting subtest: addfb25-yf-tiled-legacy [174.086127] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [174.188271] [060/170] (865s left) kms_addfb_basic (addfb25-y-tiled-legacy) [177.990979] Starting subtest: addfb25-y-tiled-legacy [177.991664] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [178.111094] [061/170] (862s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [181.914261] Starting subtest: addfb25-y-tiled-small-legacy [181.915243] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [182.030513] [062/170] (858s left) kms_addfb_basic (bad-pitch-0) [182.066911] Starting subtest: bad-pitch-0 [182.067906] Subtest bad-pitch-0: SUCCESS (0.000s) [185.934373] [063/170] (854s left) kms_addfb_basic (bad-pitch-1024) [185.972488] Starting subtest: bad-pitch-1024 [185.973312] Subtest bad-pitch-1024: SUCCESS (0.000s) [189.851395] [064/170] (850s left) kms_addfb_basic (bad-pitch-128) [189.887687] Starting subtest: bad-pitch-128 [189.888438] Subtest bad-pitch-128: SUCCESS (0.000s) [193.761338] [065/170] (846s left) kms_addfb_basic (bad-pitch-256) [193.796714] Starting subtest: bad-pitch-256 [193.797499] Subtest bad-pitch-256: SUCCESS (0.000s) [197.676427] [066/170] (842s left) kms_addfb_basic (bad-pitch-32) [197.711633] Starting subtest: bad-pitch-32 [197.712509] Subtest bad-pitch-32: SUCCESS (0.000s) [201.574187] [067/170] (838s left) kms_addfb_basic (bad-pitch-63) [201.609109] Starting subtest: bad-pitch-63 [201.610029] Subtest bad-pitch-63: SUCCESS (0.000s) [205.486476] [068/170] (834s left) kms_addfb_basic (bad-pitch-65536) [205.523564] Starting subtest: bad-pitch-65536 [205.524289] Subtest bad-pitch-65536: SUCCESS (0.000s) [209.393122] [069/170] (830s left) kms_addfb_basic (bad-pitch-999) [209.434782] Starting subtest: bad-pitch-999 [209.435641] Subtest bad-pitch-999: SUCCESS (0.000s) [213.308968] [070/170] (826s left) kms_addfb_basic (basic) [213.345191] Starting subtest: basic [213.346119] Subtest basic: SUCCESS (0.000s) [217.211518] [071/170] (823s left) kms_addfb_basic (basic-x-tiled-legacy) [217.247414] Starting subtest: basic-x-tiled-legacy [217.248282] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [221.135215] [072/170] (819s left) kms_addfb_basic (basic-y-tiled-legacy) [221.173355] Starting subtest: basic-y-tiled-legacy [221.174362] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [225.049848] [073/170] (815s left) kms_addfb_basic (bo-too-small) [228.846298] Starting subtest: bo-too-small [228.847266] Subtest bo-too-small: SUCCESS (0.000s) [228.960822] [074/170] (811s left) kms_addfb_basic (bo-too-small-due-to-tiling) [232.758108] Starting subtest: bo-too-small-due-to-tiling [232.759114] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [232.862433] [075/170] (807s left) kms_addfb_basic (clobberred-modifier) [232.898209] Starting subtest: clobberred-modifier [232.898867] Subtest clobberred-modifier: SUCCESS (0.000s) [236.761320] [076/170] (803s left) kms_addfb_basic (framebuffer-vs-set-tiling) [236.798090] Starting subtest: framebuffer-vs-set-tiling [236.799110] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [240.665561] [077/170] (799s left) kms_addfb_basic (invalid-get-prop) [240.704185] Starting subtest: invalid-get-prop [240.704905] Subtest invalid-get-prop: SUCCESS (0.000s) [244.583370] [078/170] (795s left) kms_addfb_basic (invalid-get-prop-any) [244.618517] Starting subtest: invalid-get-prop-any [244.619310] Subtest invalid-get-prop-any: SUCCESS (0.000s) [248.492660] [079/170] (791s left) kms_addfb_basic (invalid-set-prop) [248.528211] Starting subtest: invalid-set-prop [248.528920] Subtest invalid-set-prop: SUCCESS (0.000s) [252.410934] [080/170] (787s left) kms_addfb_basic (invalid-set-prop-any) [252.449514] Starting subtest: invalid-set-prop-any [252.450255] Subtest invalid-set-prop-any: SUCCESS (0.000s) [256.328396] [081/170] (784s left) kms_addfb_basic (no-handle) [256.365881] Starting subtest: no-handle [256.366879] Subtest no-handle: SUCCESS (0.000s) [260.237159] [082/170] (780s left) kms_addfb_basic (size-max) [264.036837] Starting subtest: size-max [264.037941] Subtest size-max: SUCCESS (0.000s) [264.141689] [083/170] (776s left) kms_addfb_basic (small-bo) [267.922857] Starting subtest: small-bo [267.923962] Subtest small-bo: SUCCESS (0.000s) [268.024500] [084/170] (772s left) kms_addfb_basic (tile-pitch-mismatch) [268.060634] Starting subtest: tile-pitch-mismatch [268.061691] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [271.918097] [085/170] (768s left) kms_addfb_basic (too-high) [275.718660] Starting subtest: too-high [275.719579] Subtest too-high: SUCCESS (0.000s) [275.829227] [086/170] (764s left) kms_addfb_basic (too-wide) [279.630538] Starting subtest: too-wide [279.631291] Subtest too-wide: SUCCESS (0.000s) [279.726470] [087/170] (760s left) kms_addfb_basic (unused-handle) [279.762157] Starting subtest: unused-handle [279.763141] Subtest unused-handle: SUCCESS (0.000s) [283.636709] [088/170] (756s left) kms_addfb_basic (unused-modifier) [283.672123] Starting subtest: unused-modifier [283.672889] Subtest unused-modifier: SUCCESS (0.000s) [287.536516] [089/170] (752s left) kms_addfb_basic (unused-offsets) [287.573533] Starting subtest: unused-offsets [287.574265] Subtest unused-offsets: SUCCESS (0.000s) [291.453454] [090/170] (749s left) kms_addfb_basic (unused-pitches) [291.491055] Starting subtest: unused-pitches [291.492095] Subtest unused-pitches: SUCCESS (0.000s) [295.369741] [091/170] (745s left) kms_busy (basic) [299.175252] Starting subtest: basic [299.176125] Starting dynamic subtest: flip [301.141909] Dynamic subtest flip: SUCCESS (1.966s) [301.148779] Starting dynamic subtest: modeset [304.874524] Dynamic subtest modeset: SUCCESS (3.732s) [304.875557] Subtest basic: SUCCESS (5.699s) [305.912512] [092/170] (734s left) kms_chamelium_hpd (dp-hpd-fast) [310.057332] Subtest dp-hpd-fast: SKIP (0.000s) [310.983657] [093/170] (729s left) kms_chamelium_edid (dp-edid-read) [315.134407] Subtest dp-edid-read: SKIP (0.000s) [316.063255] [094/170] (724s left) kms_chamelium_frames (dp-crc-fast) [320.231171] Subtest dp-crc-fast: SKIP (0.000s) [321.164208] [095/170] (719s left) kms_chamelium_hpd (hdmi-hpd-fast) [325.314587] Subtest hdmi-hpd-fast: SKIP (0.000s) [326.242728] [096/170] (714s left) kms_chamelium_edid (hdmi-edid-read) [330.390437] Subtest hdmi-edid-read: SKIP (0.000s) [331.326925] [097/170] (709s left) kms_chamelium_frames (hdmi-crc-fast) [335.452264] Subtest hdmi-crc-fast: SKIP (0.000s) [336.398841] [098/170] (704s left) kms_chamelium_hpd (vga-hpd-fast) [340.548275] Subtest vga-hpd-fast: SKIP (0.000s) [341.483374] [099/170] (699s left) kms_chamelium_edid (vga-edid-read) [345.648600] Subtest vga-edid-read: SKIP (0.000s) [346.580283] [100/170] (694s left) kms_prop_blob (basic) [346.618229] Starting subtest: basic [346.619213] Subtest basic: SUCCESS (0.000s) [346.705623] [101/170] (693s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [350.537474] Starting subtest: basic-busy-flip-before-cursor-atomic [350.539532] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [350.655033] [102/170] (689s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [354.488542] Starting subtest: basic-busy-flip-before-cursor-legacy [354.490558] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [354.622902] [103/170] (686s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [358.445610] Starting subtest: basic-flip-after-cursor-atomic [360.823443] Subtest basic-flip-after-cursor-atomic: SUCCESS (2.379s) [361.913348] [104/170] (678s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [365.739571] Starting subtest: basic-flip-after-cursor-legacy [368.117969] Subtest basic-flip-after-cursor-legacy: SUCCESS (2.378s) [369.211370] [105/170] (671s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [373.035889] Starting subtest: basic-flip-after-cursor-varying-size [375.417944] Subtest basic-flip-after-cursor-varying-size: SUCCESS (2.383s) [376.512498] [106/170] (664s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [380.333479] Starting subtest: basic-flip-before-cursor-atomic [382.718297] Subtest basic-flip-before-cursor-atomic: SUCCESS (2.385s) [383.807735] [107/170] (656s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [387.633591] Starting subtest: basic-flip-before-cursor-legacy [390.013029] Subtest basic-flip-before-cursor-legacy: SUCCESS (2.379s) [391.098689] [108/170] (649s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [394.927381] Starting subtest: basic-flip-before-cursor-varying-size [397.308444] Subtest basic-flip-before-cursor-varying-size: SUCCESS (2.382s) [398.394631] [109/170] (642s left) kms_flip (basic-flip-vs-dpms) [400.333626] Starting subtest: basic-flip-vs-dpms [400.335726] Starting dynamic subtest: A-eDP1 [403.050192] Dynamic subtest A-eDP1: SUCCESS (2.714s) [403.055046] Starting dynamic subtest: B-eDP1 [405.416050] Dynamic subtest B-eDP1: SUCCESS (2.364s) [405.423047] Starting dynamic subtest: C-eDP1 [407.784893] Dynamic subtest C-eDP1: SUCCESS (2.369s) [407.790027] Starting dynamic subtest: D-eDP1 [410.157152] Dynamic subtest D-eDP1: SUCCESS (2.373s) [410.163149] Starting dynamic subtest: A-DP3 [410.955138] Dynamic subtest A-DP3: SUCCESS (0.796s) [410.962841] Starting dynamic subtest: B-DP3 [411.690144] Dynamic subtest B-DP3: SUCCESS (0.735s) [411.695301] Starting dynamic subtest: C-DP3 [412.420670] Dynamic subtest C-DP3: SUCCESS (0.730s) [412.427695] Starting dynamic subtest: D-DP3 [413.162018] Dynamic subtest D-DP3: SUCCESS (0.740s) [413.162756] Subtest basic-flip-vs-dpms: SUCCESS (12.828s) [413.648644] [110/170] (627s left) kms_flip (basic-flip-vs-modeset) [415.591799] Starting subtest: basic-flip-vs-modeset [415.593752] Starting dynamic subtest: A-eDP1 [418.347447] Dynamic subtest A-eDP1: SUCCESS (2.752s) [418.352619] Starting dynamic subtest: B-eDP1 [420.716126] Dynamic subtest B-eDP1: SUCCESS (2.369s) [420.723166] Starting dynamic subtest: C-eDP1 [423.077984] Dynamic subtest C-eDP1: SUCCESS (2.361s) [423.085512] Starting dynamic subtest: D-eDP1 [425.444852] Dynamic subtest D-eDP1: SUCCESS (2.367s) [425.456047] Starting dynamic subtest: A-DP3 [426.237725] Dynamic subtest A-DP3: SUCCESS (0.791s) [426.243036] Starting dynamic subtest: B-DP3 [426.961906] Dynamic subtest B-DP3: SUCCESS (0.724s) [426.966898] Starting dynamic subtest: C-DP3 [427.697513] Dynamic subtest C-DP3: SUCCESS (0.735s) [427.704541] Starting dynamic subtest: D-DP3 [428.431958] Dynamic subtest D-DP3: SUCCESS (0.733s) [428.432746] Subtest basic-flip-vs-modeset: SUCCESS (12.840s) [428.917701] [111/170] (611s left) kms_flip (basic-flip-vs-wf_vblank) [430.857244] Starting subtest: basic-flip-vs-wf_vblank [430.859736] Starting dynamic subtest: A-eDP1 [432.901743] Dynamic subtest A-eDP1: SUCCESS (2.042s) [432.909101] Starting dynamic subtest: B-eDP1 [434.941707] Dynamic subtest B-eDP1: SUCCESS (2.038s) [434.949196] Starting dynamic subtest: C-eDP1 [436.972107] Dynamic subtest C-eDP1: SUCCESS (2.030s) [436.977341] Starting dynamic subtest: D-eDP1 [439.015939] Dynamic subtest D-eDP1: SUCCESS (2.043s) [439.021678] Starting dynamic subtest: A-DP3 [440.345901] Dynamic subtest A-DP3: SUCCESS (1.328s) [440.355878] Starting dynamic subtest: B-DP3 [441.427761] Dynamic subtest B-DP3: SUCCESS (1.082s) [441.432742] Starting dynamic subtest: C-DP3 [442.493910] Dynamic subtest C-DP3: SUCCESS (1.065s) [442.498964] Starting dynamic subtest: D-DP3 [443.562216] Dynamic subtest D-DP3: SUCCESS (1.069s) [443.563120] Subtest basic-flip-vs-wf_vblank: SUCCESS (12.706s) [444.094907] [112/170] (596s left) kms_flip (basic-plain-flip) [446.034279] Starting subtest: basic-plain-flip [446.037078] Starting dynamic subtest: A-eDP1 [447.793293] Dynamic subtest A-eDP1: SUCCESS (1.757s) [447.805199] Starting dynamic subtest: B-eDP1 [449.569055] Dynamic subtest B-eDP1: SUCCESS (1.774s) [449.577572] Starting dynamic subtest: C-eDP1 [451.342848] Dynamic subtest C-eDP1: SUCCESS (1.774s) [451.348125] Starting dynamic subtest: D-eDP1 [453.070294] Dynamic subtest D-eDP1: SUCCESS (1.727s) [453.076770] Starting dynamic subtest: A-DP3 [454.119397] Dynamic subtest A-DP3: SUCCESS (1.046s) [454.126636] Starting dynamic subtest: B-DP3 [454.918958] Dynamic subtest B-DP3: SUCCESS (0.799s) [454.924456] Starting dynamic subtest: C-DP3 [455.702064] Dynamic subtest C-DP3: SUCCESS (0.783s) [455.707056] Starting dynamic subtest: D-DP3 [456.485620] Dynamic subtest D-DP3: SUCCESS (0.782s) [456.486640] Subtest basic-plain-flip: SUCCESS (10.451s) [457.009864] [113/170] (583s left) kms_force_connector_basic (force-connector-state) [457.047912] Starting subtest: force-connector-state [461.553810] Subtest force-connector-state: SUCCESS (4.505s) [466.318177] [114/170] (574s left) kms_force_connector_basic (force-edid) [466.356804] Starting subtest: force-edid [466.393423] Subtest force-edid: SUCCESS (0.036s) [470.314385] [115/170] (570s left) kms_force_connector_basic (force-load-detect) [470.351365] Starting subtest: force-load-detect [470.352794] Subtest force-load-detect: SKIP (0.000s) [472.356217] [116/170] (568s left) kms_force_connector_basic (prune-stale-modes) [472.393956] Starting subtest: prune-stale-modes [472.427894] Subtest prune-stale-modes: SUCCESS (0.035s) [476.346605] [117/170] (564s left) kms_frontbuffer_tracking (basic) [480.145735] Starting subtest: basic [485.112067] Subtest basic: SUCCESS (4.967s) [486.477478] [118/170] (554s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [490.277336] Starting subtest: compare-crc-sanitycheck [490.278107] Starting dynamic subtest: pipe-A-eDP-1 [492.196904] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.918s) [492.204499] Starting dynamic subtest: pipe-B-DP-3 [492.739567] Dynamic subtest pipe-B-DP-3: SUCCESS (0.542s) [492.745957] Starting dynamic subtest: pipe-C-DP-3 [493.197538] Dynamic subtest pipe-C-DP-3: SUCCESS (0.457s) [493.203866] Starting dynamic subtest: pipe-D-DP-3 [493.653846] Dynamic subtest pipe-D-DP-3: SUCCESS (0.455s) [493.654751] Subtest compare-crc-sanitycheck: SUCCESS (3.377s) [494.110587] [119/170] (546s left) kms_pipe_crc_basic (hang-read-crc) [497.915042] Starting subtest: hang-read-crc [497.915985] Starting dynamic subtest: pipe-A-eDP-1 [501.403255] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.488s) [501.408537] Starting dynamic subtest: pipe-B-DP-3 [502.788302] Dynamic subtest pipe-B-DP-3: SUCCESS (1.384s) [502.793477] Starting dynamic subtest: pipe-C-DP-3 [504.065120] Dynamic subtest pipe-C-DP-3: SUCCESS (1.275s) [504.070226] Starting dynamic subtest: pipe-D-DP-3 [505.359357] Dynamic subtest pipe-D-DP-3: SUCCESS (1.294s) [505.360229] Subtest hang-read-crc: SUCCESS (7.445s) [505.822267] [120/170] (535s left) kms_pipe_crc_basic (nonblocking-crc) [509.637625] Starting subtest: nonblocking-crc [509.638429] Starting dynamic subtest: pipe-A-eDP-1 [511.740366] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.103s) [511.746719] Starting dynamic subtest: pipe-B-DP-3 [512.462949] Dynamic subtest pipe-B-DP-3: SUCCESS (0.720s) [512.468165] Starting dynamic subtest: pipe-C-DP-3 [513.090499] Dynamic subtest pipe-C-DP-3: SUCCESS (0.627s) [513.099621] Starting dynamic subtest: pipe-D-DP-3 [513.719180] Dynamic subtest pipe-D-DP-3: SUCCESS (0.627s) [513.720047] Subtest nonblocking-crc: SUCCESS (4.082s) [514.179609] [121/170] (526s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [517.990248] Starting subtest: nonblocking-crc-frame-sequence [517.990973] Starting dynamic subtest: pipe-A-eDP-1 [520.053139] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.063s) [520.059425] Starting dynamic subtest: pipe-B-DP-3 [520.766962] Dynamic subtest pipe-B-DP-3: SUCCESS (0.712s) [520.772043] Starting dynamic subtest: pipe-C-DP-3 [521.396045] Dynamic subtest pipe-C-DP-3: SUCCESS (0.627s) [521.403178] Starting dynamic subtest: pipe-D-DP-3 [522.025628] Dynamic subtest pipe-D-DP-3: SUCCESS (0.629s) [522.026596] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.035s) [522.483508] [122/170] (518s left) kms_pipe_crc_basic (read-crc) [526.285719] Starting subtest: read-crc [526.286645] Starting dynamic subtest: pipe-A-eDP-1 [528.332494] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.046s) [528.339572] Starting dynamic subtest: pipe-B-DP-3 [528.968676] Dynamic subtest pipe-B-DP-3: SUCCESS (0.635s) [528.973787] Starting dynamic subtest: pipe-C-DP-3 [529.531577] Dynamic subtest pipe-C-DP-3: SUCCESS (0.562s) [529.540159] Starting dynamic subtest: pipe-D-DP-3 [530.096123] Dynamic subtest pipe-D-DP-3: SUCCESS (0.563s) [530.096872] Subtest read-crc: SUCCESS (3.811s) [530.557010] [123/170] (510s left) kms_pipe_crc_basic (read-crc-frame-sequence) [534.354916] Starting subtest: read-crc-frame-sequence [534.355762] Starting dynamic subtest: pipe-A-eDP-1 [536.373486] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.018s) [536.378596] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1815 [max: 8192] direct dependencies: 18262 [max: 32768] indirect dependencies: 137671 all direct dependencies: 388750 dependency chains: 26931 [max: 131072] dependency chain hlocks used: 116047 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 302 in-softirq chains: 632 in-process chains: 25997 stack-trace entries: 167595 [max: 1048576] number of stack traces: 8685 number of stack hash chains: 6743 combined max dependencies: 691423106 hardirq-safe locks: 107 hardirq-unsafe locks: 1077 softirq-safe locks: 216 softirq-unsafe locks: 988 irq-safe locks: 237 irq-unsafe locks: 1077 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 331 softirq-read-safe locks: 7 softirq-read-unsafe locks: 326 irq-read-safe locks: 7 irq-read-unsafe locks: 331 uncategorized locks: 284 unused locks: 1 max locking depth: 19 max bfs queue depth: 412 max lock class index: 1814 chain lookup misses: 27407 chain lookup hits: 708639547 cyclic checks: 27368 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4807 find-mask backwards checks: 2724 hardirq on events: 348596387 hardirq off events: 348596371 redundant hardirq ons: 48 redundant hardirq offs: 35 softirq on events: 2536609 softirq off events: 2536609 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 116 large chain blocks: 1 [536.380320] Starting dynamic subtest: pipe-B-DP-3 [537.010439] Dynamic subtest pipe-B-DP-3: SUCCESS (0.635s) [537.011132] Starting dynamic subtest: pipe-C-DP-3 [537.555620] Dynamic subtest pipe-C-DP-3: SUCCESS (0.545s) [537.556454] Starting dynamic subtest: pipe-D-DP-3 [538.119805] Dynamic subtest pipe-D-DP-3: SUCCESS (0.563s) [538.120707] Subtest read-crc-frame-sequence: SUCCESS (3.765s) [538.581099] Closing watchdogs Done.