[42.429694] Initializing watchdogs [42.429784] /dev/watchdog0 [42.434832] [001/165] (960s left) i915_module_load (load) [42.495220] Starting subtest: load [45.736689] Subtest load: SUCCESS (3.242s) [45.749643] [002/165] (957s left) core_auth (basic-auth) [45.820135] Starting subtest: basic-auth [45.820782] Subtest basic-auth: SUCCESS (0.001s) [45.900141] [003/165] (957s left) debugfs_test (read_all_entries) [45.967911] Starting subtest: read_all_entries [46.675553] Subtest read_all_entries: SUCCESS (0.706s) [47.213784] [004/165] (955s left) debugfs_test (basic-hwmon) [47.270524] Starting subtest: basic-hwmon [47.271968] Subtest basic-hwmon: SKIP (0.000s) [47.779213] [005/165] (955s left) fbdev (eof) [47.855100] Starting subtest: eof [47.855765] Subtest eof: SUCCESS (0.001s) [47.903892] [006/165] (955s left) fbdev (info) [47.960403] Starting subtest: info [47.960869] Subtest info: SUCCESS (0.000s) [48.018387] [007/165] (955s left) fbdev (nullptr) [48.070927] Starting subtest: nullptr [48.072500] Subtest nullptr: SUCCESS (0.000s) [48.119571] [008/165] (954s left) fbdev (read) [48.187984] Starting subtest: read [48.430879] Subtest read: SUCCESS (0.243s) [48.466876] [009/165] (954s left) fbdev (write) [48.521083] Starting subtest: write [48.646906] Subtest write: SUCCESS (0.126s) [48.684420] [010/165] (954s left) gem_basic (bad-close) [48.736196] Starting subtest: bad-close [48.737719] Subtest bad-close: SUCCESS (0.000s) [48.804160] [011/165] (954s left) gem_basic (create-close) [48.864139] Starting subtest: create-close [48.864964] Subtest create-close: SUCCESS (0.000s) [48.959089] [012/165] (954s left) gem_basic (create-fd-close) [49.033043] Starting subtest: create-fd-close [49.034063] Subtest create-fd-close: SUCCESS (0.000s) [49.102477] [013/165] (954s left) gem_busy (busy@all-engines) [49.172046] Starting subtest: busy [49.172586] Starting dynamic subtest: all-engines [49.231342] Dynamic subtest all-engines: SUCCESS (0.059s) [49.231951] Subtest busy: SUCCESS (0.059s) [49.644184] [014/165] (953s left) gem_close_race (basic-process) [49.711799] Starting subtest: basic-process [49.777106] Subtest basic-process: SUCCESS (0.065s) [49.991500] [015/165] (953s left) gem_close_race (basic-threads) [50.085267] Starting subtest: basic-threads [51.257325] Subtest basic-threads: SUCCESS (1.173s) [51.472894] [016/165] (951s left) gem_ctx_create (basic) [51.556276] Starting subtest: basic [51.556916] Subtest basic: SUCCESS (0.000s) [51.749969] [017/165] (951s left) gem_ctx_create (basic-files) [51.832640] Starting subtest: basic-files [53.850335] Subtest basic-files: SUCCESS (2.018s) [54.084941] [018/165] (949s left) gem_ctx_exec (basic) [54.143245] Starting subtest: basic [54.146412] Subtest basic: SUCCESS (0.003s) [54.251636] [019/165] (949s left) gem_exec_basic (basic) [54.341058] Starting subtest: basic [54.341661] Starting dynamic subtest: rcs0-smem [54.342285] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [54.349153] Starting dynamic subtest: bcs0-smem [54.349626] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [54.354610] Starting dynamic subtest: vcs0-smem [54.355445] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [54.360616] Starting dynamic subtest: vcs1-smem [54.361682] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [54.366957] Starting dynamic subtest: vecs0-smem [54.368227] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [54.369367] Subtest basic: SUCCESS (0.004s) [54.581171] [020/165] (948s left) gem_exec_create (basic) [54.645759] Starting subtest: basic [54.647908] Starting dynamic subtest: smem [56.696053] Dynamic subtest smem: SUCCESS (2.050s) [56.696737] Subtest basic: SUCCESS (2.050s) [56.901828] [021/165] (946s left) gem_exec_fence (basic-busy) [57.121422] Starting subtest: basic-busy [57.123633] Starting dynamic subtest: rcs0 [57.148364] Dynamic subtest rcs0: SUCCESS (0.030s) [57.159256] Starting dynamic subtest: bcs0 [57.183431] Dynamic subtest bcs0: SUCCESS (0.035s) [57.194186] Starting dynamic subtest: vcs0 [57.223182] Dynamic subtest vcs0: SUCCESS (0.038s) [57.237186] Starting dynamic subtest: vcs1 [57.249397] Dynamic subtest vcs1: SUCCESS (0.024s) [57.267643] Starting dynamic subtest: vecs0 [57.270590] Dynamic subtest vecs0: SUCCESS (0.024s) [57.271631] Subtest basic-busy: SUCCESS (0.152s) [57.932251] [022/165] (945s left) gem_exec_fence (basic-wait) [58.129689] Starting subtest: basic-wait [58.131449] Starting dynamic subtest: rcs0 [58.155378] Dynamic subtest rcs0: SUCCESS (0.024s) [58.170073] Starting dynamic subtest: bcs0 [58.190338] Dynamic subtest bcs0: SUCCESS (0.035s) [58.209988] Starting dynamic subtest: vcs0 [58.217094] Dynamic subtest vcs0: SUCCESS (0.026s) [58.224787] Starting dynamic subtest: vcs1 [58.244238] Dynamic subtest vcs1: SUCCESS (0.028s) [58.250752] Starting dynamic subtest: vecs0 [58.263930] Dynamic subtest vecs0: SUCCESS (0.021s) [58.264589] Subtest basic-wait: SUCCESS (0.135s) [58.863417] [023/165] (944s left) gem_exec_fence (basic-await) [59.061068] Starting subtest: basic-await [59.061969] Starting dynamic subtest: rcs0 [59.164449] Dynamic subtest rcs0: SUCCESS (0.103s) [59.171353] Starting dynamic subtest: bcs0 [59.259704] Dynamic subtest bcs0: SUCCESS (0.095s) [59.267704] Starting dynamic subtest: vcs0 [59.365373] Dynamic subtest vcs0: SUCCESS (0.103s) [59.372245] Starting dynamic subtest: vcs1 [59.474988] Dynamic subtest vcs1: SUCCESS (0.108s) [59.487935] Starting dynamic subtest: vecs0 [59.611051] Dynamic subtest vecs0: SUCCESS (0.136s) [59.611831] Subtest basic-await: SUCCESS (0.548s) [60.221797] [024/165] (943s left) gem_exec_fence (nb-await) [60.436351] Starting subtest: nb-await [60.437340] Starting dynamic subtest: rcs0 [60.506313] Dynamic subtest rcs0: SUCCESS (0.066s) [60.532470] Starting dynamic subtest: bcs0 [60.591481] Dynamic subtest bcs0: SUCCESS (0.085s) [60.614932] Starting dynamic subtest: vcs0 [60.677221] Dynamic subtest vcs0: SUCCESS (0.086s) [60.707832] Starting dynamic subtest: vcs1 [60.768850] Dynamic subtest vcs1: SUCCESS (0.091s) [60.795074] Starting dynamic subtest: vecs0 [60.857883] Dynamic subtest vecs0: SUCCESS (0.088s) [60.860485] Subtest nb-await: SUCCESS (0.420s) [61.520464] [025/165] (941s left) gem_exec_gttfill (basic) [61.614477] Starting subtest: basic [69.752034] Subtest basic: SUCCESS (8.138s) [69.922977] [026/165] (933s left) gem_exec_parallel (engines) [70.061641] Starting subtest: engines [70.062490] Starting dynamic subtest: basic [72.450778] Dynamic subtest basic: SUCCESS (2.387s) [72.456955] Starting dynamic subtest: contexts [75.283109] Dynamic subtest contexts: SUCCESS (2.834s) [75.289387] Starting dynamic subtest: fds [81.403177] Dynamic subtest fds: SUCCESS (6.120s) [81.409854] Starting dynamic subtest: userptr [83.792742] Dynamic subtest userptr: SUCCESS (2.389s) [83.793380] Subtest engines: SUCCESS (13.731s) [83.995290] [027/165] (919s left) gem_exec_store (basic) [84.062304] Starting subtest: basic [84.119235] Subtest basic: SUCCESS (0.057s) [84.335912] [028/165] (919s left) gem_flink_basic (bad-flink) [84.411979] Starting subtest: bad-flink [84.412625] Subtest bad-flink: SUCCESS (0.000s) [84.468951] [029/165] (919s left) gem_flink_basic (bad-open) [84.520369] Starting subtest: bad-open [84.521023] Subtest bad-open: SUCCESS (0.000s) [84.587044] [030/165] (918s left) gem_flink_basic (basic) [84.642314] Starting subtest: basic [84.642876] Subtest basic: SUCCESS (0.000s) [84.705208] [031/165] (918s left) gem_flink_basic (double-flink) [84.766532] Starting subtest: double-flink [84.767115] Subtest double-flink: SUCCESS (0.000s) [84.843378] [032/165] (918s left) gem_flink_basic (flink-lifetime) [84.911446] Starting subtest: flink-lifetime [84.913029] Subtest flink-lifetime: SUCCESS (0.001s) [84.990946] [033/165] (918s left) gem_huc_copy (huc-copy) [85.061163] Starting subtest: huc-copy [85.062499] Subtest huc-copy: SKIP (0.000s) [85.173824] [034/165] (918s left) gem_linear_blits (basic) [85.359108] Starting subtest: basic [85.365211] Subtest basic: SUCCESS (0.009s) [85.513225] [035/165] (918s left) gem_mmap (basic) [85.710525] Starting subtest: basic [85.715515] Subtest basic: SUCCESS (0.001s) [85.805610] [036/165] (917s left) gem_mmap_gtt (basic) [85.882106] Starting subtest: basic [85.882845] Subtest basic: SUCCESS (0.001s) [85.928362] [037/165] (917s left) gem_render_linear_blits (basic) [85.982766] Starting subtest: basic [86.012325] Subtest basic: SUCCESS (0.029s) [86.044959] [038/165] (917s left) gem_render_tiled_blits (basic) [86.099238] Starting subtest: basic [86.132672] Subtest basic: SUCCESS (0.033s) [86.177893] [039/165] (917s left) gem_ringfill (basic-all) [86.433916] Starting subtest: basic-all [87.611886] Subtest basic-all: SUCCESS (1.179s) [87.714064] [040/165] (916s left) gem_softpin (allocator-basic) [87.795103] Starting subtest: allocator-basic [87.904133] Subtest allocator-basic: SUCCESS (0.106s) [87.987431] [041/165] (915s left) gem_softpin (allocator-basic-reserve) [88.047941] Starting subtest: allocator-basic-reserve [88.153154] Subtest allocator-basic-reserve: SUCCESS (0.102s) [88.236284] [042/165] (915s left) gem_softpin (safe-alignment) [88.296855] Starting subtest: safe-alignment [88.312072] Subtest safe-alignment: SUCCESS (0.013s) [88.431461] [043/165] (915s left) gem_sync (basic-all) [88.509936] Starting subtest: basic-all [90.647970] Subtest basic-all: SUCCESS (2.138s) [90.850243] [044/165] (913s left) gem_sync (basic-each) [90.932845] Starting subtest: basic-each [93.121125] Subtest basic-each: SUCCESS (2.188s) [93.335275] [045/165] (910s left) gem_tiled_blits (basic) [93.508589] Starting subtest: basic [93.526200] Subtest basic: SUCCESS (0.018s) [93.682507] [046/165] (910s left) gem_tiled_fence_blits (basic) [93.988993] Starting subtest: basic [94.001774] Subtest basic: SUCCESS (0.012s) [94.137612] [047/165] (909s left) gem_tiled_pread_basic [94.529222] [048/165] (909s left) gem_wait (busy@all-engines) [94.620228] Starting subtest: busy [94.620940] Starting dynamic subtest: all-engines [95.144832] Dynamic subtest all-engines: SUCCESS (0.525s) [95.145389] Subtest busy: SUCCESS (0.525s) [95.416918] [049/165] (908s left) gem_wait (wait@all-engines) [95.485647] Starting subtest: wait [95.486359] Starting dynamic subtest: all-engines [96.527487] Dynamic subtest all-engines: SUCCESS (1.037s) [96.529876] Subtest wait: SUCCESS (1.038s) [96.791872] [050/165] (907s left) i915_getparams_basic (basic-eu-total) [96.854846] Starting subtest: basic-eu-total [96.856234] Subtest basic-eu-total: SUCCESS (0.000s) [96.943118] [051/165] (907s left) i915_getparams_basic (basic-subslice-total) [96.996754] Starting subtest: basic-subslice-total [96.998118] Subtest basic-subslice-total: SUCCESS (0.000s) [97.053993] [052/165] (907s left) i915_hangman (error-state-basic) [97.122271] Starting subtest: error-state-basic [97.130263] Subtest error-state-basic: SUCCESS (0.006s) [97.185447] [053/165] (906s left) i915_pciid [97.305543] [054/165] (906s left) kms_addfb_basic (addfb25-4-tiled) [97.787510] Starting subtest: addfb25-4-tiled [97.787939] Subtest addfb25-4-tiled: SUCCESS (0.000s) [97.852644] [055/165] (906s left) kms_addfb_basic (addfb25-bad-modifier) [97.906207] Starting subtest: addfb25-bad-modifier [97.906873] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [98.387155] [056/165] (905s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [98.441301] Starting subtest: addfb25-framebuffer-vs-set-tiling [98.441943] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [98.936880] [057/165] (905s left) kms_addfb_basic (addfb25-modifier-no-flag) [98.991756] Starting subtest: addfb25-modifier-no-flag [98.992414] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [99.478158] [058/165] (904s left) kms_addfb_basic (addfb25-x-tiled-legacy) [99.535692] Starting subtest: addfb25-x-tiled-legacy [99.536419] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [100.037895] [059/165] (904s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [100.099084] Starting subtest: addfb25-x-tiled-mismatch-legacy [100.099741] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [100.570497] [060/165] (903s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [101.038955] Starting subtest: addfb25-yf-tiled-legacy [101.039630] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [101.119667] [061/165] (903s left) kms_addfb_basic (addfb25-y-tiled-legacy) [101.584148] Starting subtest: addfb25-y-tiled-legacy [101.584883] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [101.655182] [062/165] (902s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [102.129163] Starting subtest: addfb25-y-tiled-small-legacy [102.130183] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [102.204086] [063/165] (902s left) kms_addfb_basic (bad-pitch-0) [102.258877] Starting subtest: bad-pitch-0 [102.259465] Subtest bad-pitch-0: SUCCESS (0.000s) [102.786470] [064/165] (901s left) kms_addfb_basic (bad-pitch-1024) [102.837046] Starting subtest: bad-pitch-1024 [102.837681] Subtest bad-pitch-1024: SUCCESS (0.000s) [103.320824] [065/165] (900s left) kms_addfb_basic (bad-pitch-128) [103.372322] Starting subtest: bad-pitch-128 [103.373157] Subtest bad-pitch-128: SUCCESS (0.000s) [103.877786] [066/165] (900s left) kms_addfb_basic (bad-pitch-256) [103.933689] Starting subtest: bad-pitch-256 [103.934175] Subtest bad-pitch-256: SUCCESS (0.000s) [104.422766] [067/165] (899s left) kms_addfb_basic (bad-pitch-32) [104.476775] Starting subtest: bad-pitch-32 [104.477517] Subtest bad-pitch-32: SUCCESS (0.000s) [104.953493] [068/165] (899s left) kms_addfb_basic (bad-pitch-63) [105.007027] Starting subtest: bad-pitch-63 [105.007711] Subtest bad-pitch-63: SUCCESS (0.000s) [105.502425] [069/165] (898s left) kms_addfb_basic (bad-pitch-65536) [105.557097] Starting subtest: bad-pitch-65536 [105.557649] Subtest bad-pitch-65536: SUCCESS (0.000s) [106.051903] [070/165] (898s left) kms_addfb_basic (bad-pitch-999) [106.112899] Starting subtest: bad-pitch-999 [106.113390] Subtest bad-pitch-999: SUCCESS (0.000s) [106.603303] [071/165] (897s left) kms_addfb_basic (basic) [106.656216] Starting subtest: basic [106.656883] Subtest basic: SUCCESS (0.000s) [107.155790] [072/165] (897s left) kms_addfb_basic (basic-x-tiled-legacy) [107.212205] Starting subtest: basic-x-tiled-legacy [107.212754] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [107.706996] [073/165] (896s left) kms_addfb_basic (basic-y-tiled-legacy) [107.762363] Starting subtest: basic-y-tiled-legacy [107.762990] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [108.256930] [074/165] (896s left) kms_addfb_basic (bo-too-small) [108.720101] Starting subtest: bo-too-small [108.721039] Subtest bo-too-small: SUCCESS (0.000s) [108.794421] [075/165] (895s left) kms_addfb_basic (bo-too-small-due-to-tiling) [109.279056] Starting subtest: bo-too-small-due-to-tiling [109.279795] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [109.356102] [076/165] (895s left) kms_addfb_basic (clobberred-modifier) [109.416194] Starting subtest: clobberred-modifier [109.416939] Subtest clobberred-modifier: SUCCESS (0.000s) [109.929468] [077/165] (894s left) kms_addfb_basic (framebuffer-vs-set-tiling) [109.987414] Starting subtest: framebuffer-vs-set-tiling [109.987941] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [110.503671] [078/165] (894s left) kms_addfb_basic (invalid-get-prop) [110.558559] Starting subtest: invalid-get-prop [110.559164] Subtest invalid-get-prop: SUCCESS (0.000s) [111.040352] [079/165] (893s left) kms_addfb_basic (invalid-get-prop-any) [111.094263] Starting subtest: invalid-get-prop-any [111.094771] Subtest invalid-get-prop-any: SUCCESS (0.000s) [111.593321] [080/165] (892s left) kms_addfb_basic (invalid-set-prop) [111.650329] Starting subtest: invalid-set-prop [111.650983] Subtest invalid-set-prop: SUCCESS (0.000s) [112.152606] [081/165] (892s left) kms_addfb_basic (invalid-set-prop-any) [112.207344] Starting subtest: invalid-set-prop-any [112.207994] Subtest invalid-set-prop-any: SUCCESS (0.000s) [112.705742] [082/165] (891s left) kms_addfb_basic (no-handle) [112.762153] Starting subtest: no-handle [112.762639] Subtest no-handle: SUCCESS (0.000s) [113.276153] [083/165] (891s left) kms_addfb_basic (size-max) [113.760092] Starting subtest: size-max [113.760775] Subtest size-max: SUCCESS (0.000s) [113.837811] [084/165] (890s left) kms_addfb_basic (small-bo) [114.306526] Starting subtest: small-bo [114.307287] Subtest small-bo: SUCCESS (0.000s) [114.400769] [085/165] (890s left) kms_addfb_basic (tile-pitch-mismatch) [114.463648] Starting subtest: tile-pitch-mismatch [114.464283] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [114.993429] [086/165] (889s left) kms_addfb_basic (too-high) [115.466286] Starting subtest: too-high [115.467142] Subtest too-high: SUCCESS (0.001s) [115.554234] [087/165] (889s left) kms_addfb_basic (too-wide) [116.007555] Starting subtest: too-wide [116.008278] Subtest too-wide: SUCCESS (0.000s) [116.071986] [088/165] (888s left) kms_addfb_basic (unused-handle) [116.127547] Starting subtest: unused-handle [116.128229] Subtest unused-handle: SUCCESS (0.000s) [116.639310] [089/165] (888s left) kms_addfb_basic (unused-modifier) [116.694344] Starting subtest: unused-modifier [116.694952] Subtest unused-modifier: SUCCESS (0.000s) [117.188619] [090/165] (887s left) kms_addfb_basic (unused-offsets) [117.245255] Starting subtest: unused-offsets [117.245794] Subtest unused-offsets: SUCCESS (0.000s) [117.722307] [091/165] (887s left) kms_addfb_basic (unused-pitches) [117.776583] Starting subtest: unused-pitches [117.777185] Subtest unused-pitches: SUCCESS (0.000s) [118.320276] [092/165] (886s left) kms_busy (basic) [118.790652] Starting subtest: basic [118.793349] Starting dynamic subtest: flip [120.125769] Dynamic subtest flip: SUCCESS (1.330s) [120.133502] Starting dynamic subtest: modeset [121.216568] Dynamic subtest modeset: SUCCESS (1.089s) [121.217416] Subtest basic: SUCCESS (2.424s) [121.828561] [093/165] (882s left) kms_prop_blob (basic) [121.904411] Starting subtest: basic [121.905158] Subtest basic: SUCCESS (0.000s) [121.968409] [094/165] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [122.442224] Starting subtest: basic-busy-flip-before-cursor-atomic [122.444426] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [122.519777] [095/165] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [123.010407] Starting subtest: basic-busy-flip-before-cursor-legacy [123.011941] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [123.076815] [096/165] (881s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [123.566958] Starting subtest: basic-flip-after-cursor-atomic [125.081830] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.514s) [125.618853] [097/165] (879s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [126.086413] Starting subtest: basic-flip-after-cursor-legacy [127.507254] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.420s) [128.058669] [098/165] (876s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [128.539983] Starting subtest: basic-flip-after-cursor-varying-size [130.046461] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.507s) [130.612436] [099/165] (874s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [131.099560] Starting subtest: basic-flip-before-cursor-atomic [132.588617] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.489s) [133.142342] [100/165] (871s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [133.606042] Starting subtest: basic-flip-before-cursor-legacy [135.183694] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.578s) [135.738420] [101/165] (869s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [136.219052] Starting subtest: basic-flip-before-cursor-varying-size [137.777961] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.558s) [138.369907] [102/165] (866s left) kms_dsc (dsc-basic) [138.857813] Subtest dsc-basic: SKIP (0.000s) [138.903612] [103/165] (866s left) kms_flip (basic-flip-vs-dpms) [139.391455] Starting subtest: basic-flip-vs-dpms [139.399179] Starting dynamic subtest: A-DP1 [140.941828] Dynamic subtest A-DP1: SUCCESS (1.541s) [140.966074] Starting dynamic subtest: B-DP1 [141.901713] Dynamic subtest B-DP1: SUCCESS (0.956s) [141.913774] Starting dynamic subtest: C-DP1 [142.869134] Dynamic subtest C-DP1: SUCCESS (0.963s) [142.891892] Starting dynamic subtest: A-DP3 [144.145545] Dynamic subtest A-DP3: SUCCESS (1.262s) [144.187710] Starting dynamic subtest: B-DP3 [145.500096] Dynamic subtest B-DP3: SUCCESS (1.341s) [145.535320] Starting dynamic subtest: C-DP3 [147.443462] Dynamic subtest C-DP3: SUCCESS (1.937s) [147.452395] Subtest basic-flip-vs-dpms: SUCCESS (8.056s) [148.138117] [104/165] (857s left) kms_flip (basic-flip-vs-modeset) [148.622493] Starting subtest: basic-flip-vs-modeset [148.625285] Starting dynamic subtest: A-DP1 [150.054212] Dynamic subtest A-DP1: SUCCESS (1.427s) [150.079259] Starting dynamic subtest: B-DP1 [151.005629] Dynamic subtest B-DP1: SUCCESS (0.939s) [151.021150] Starting dynamic subtest: C-DP1 [151.968942] Dynamic subtest C-DP1: SUCCESS (0.965s) [151.988631] Starting dynamic subtest: A-DP3 [153.278071] Dynamic subtest A-DP3: SUCCESS (1.293s) [153.311128] Starting dynamic subtest: B-DP3 [154.545978] Dynamic subtest B-DP3: SUCCESS (1.260s) [154.586783] Starting dynamic subtest: C-DP3 [155.891106] Dynamic subtest C-DP3: SUCCESS (1.335s) [155.893058] Subtest basic-flip-vs-modeset: SUCCESS (7.269s) [156.547593] [105/165] (848s left) kms_flip (basic-flip-vs-wf_vblank) [157.035985] Starting subtest: basic-flip-vs-wf_vblank [157.038898] Starting dynamic subtest: A-DP1 [158.457908] Dynamic subtest A-DP1: SUCCESS (1.419s) [158.469095] Starting dynamic subtest: B-DP1 [159.583353] Dynamic subtest B-DP1: SUCCESS (1.123s) [159.593343] Starting dynamic subtest: C-DP1 [160.694072] Dynamic subtest C-DP1: SUCCESS (1.108s) [160.704633] Starting dynamic subtest: A-DP3 [161.888741] Dynamic subtest A-DP3: SUCCESS (1.191s) [161.898189] Starting dynamic subtest: B-DP3 [163.417301] Dynamic subtest B-DP3: SUCCESS (1.526s) [163.432911] Starting dynamic subtest: C-DP3 [164.858481] Dynamic subtest C-DP3: SUCCESS (1.438s) [164.859341] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.827s) [165.713454] [106/165] (839s left) kms_flip (basic-plain-flip) [166.200826] Starting subtest: basic-plain-flip [166.203813] Starting dynamic subtest: A-DP1 [167.404684] Dynamic subtest A-DP1: SUCCESS (1.201s) [167.415065] Starting dynamic subtest: B-DP1 [168.260303] Dynamic subtest B-DP1: SUCCESS (0.849s) [168.311529] Starting dynamic subtest: C-DP1 [169.196139] Dynamic subtest C-DP1: SUCCESS (0.924s) [169.208980] Starting dynamic subtest: A-DP3 [170.122597] Dynamic subtest A-DP3: SUCCESS (0.925s) [170.133942] Starting dynamic subtest: B-DP3 [171.931907] Dynamic subtest B-DP3: SUCCESS (1.807s) [171.942494] Starting dynamic subtest: C-DP3 [173.081811] Dynamic subtest C-DP3: SUCCESS (1.146s) [173.095960] Subtest basic-plain-flip: SUCCESS (6.892s) [174.135163] [107/165] (831s left) kms_force_connector_basic (force-connector-state) [174.406905] Starting subtest: force-connector-state [175.638181] Subtest force-connector-state: SUCCESS (1.236s) [176.707341] [108/165] (828s left) kms_force_connector_basic (force-edid) [176.960876] Starting subtest: force-edid [177.366549] Subtest force-edid: SUCCESS (0.408s) [177.989683] [109/165] (827s left) kms_force_connector_basic (force-load-detect) [178.239784] Starting subtest: force-load-detect [178.246587] Subtest force-load-detect: SKIP (0.000s) [178.699736] [110/165] (826s left) kms_force_connector_basic (prune-stale-modes) [178.937334] Starting subtest: prune-stale-modes [179.391769] Subtest prune-stale-modes: SUCCESS (0.453s) [180.024835] [111/165] (825s left) kms_frontbuffer_tracking (basic) [180.525856] Starting subtest: basic [183.841571] Subtest basic: SUCCESS (3.314s) [184.492245] [112/165] (820s left) kms_hdmi_inject (inject-audio) [184.834713] Starting subtest: inject-audio [185.400797] Subtest inject-audio: SUCCESS (0.560s) [186.255318] [113/165] (819s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [186.736335] Starting subtest: compare-crc-sanitycheck-xr24 [186.737123] Starting dynamic subtest: pipe-A-DP-1 [188.450946] Dynamic subtest pipe-A-DP-1: SUCCESS (1.711s) [188.467354] Starting dynamic subtest: pipe-B-DP-3 [189.270675] Dynamic subtest pipe-B-DP-3: SUCCESS (0.813s) [189.320829] Starting dynamic subtest: pipe-C-DP-1 [189.894673] Dynamic subtest pipe-C-DP-1: SUCCESS (0.605s) [189.895873] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.160s) [190.482492] [114/165] (815s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [190.961763] Starting subtest: compare-crc-sanitycheck-nv12 [190.963289] Starting dynamic subtest: pipe-A-DP-1 [192.222747] Dynamic subtest pipe-A-DP-1: SUCCESS (1.258s) [192.236346] Starting dynamic subtest: pipe-B-DP-3 [193.120248] Dynamic subtest pipe-B-DP-3: SUCCESS (0.887s) [193.174371] Starting dynamic subtest: pipe-C-DP-1 [193.178546] Dynamic subtest pipe-C-DP-1: SKIP (0.004s) [193.181275] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.182s) [193.749266] [115/165] (811s left) kms_pipe_crc_basic (hang-read-crc) [194.239628] Starting subtest: hang-read-crc [194.242994] Starting dynamic subtest: pipe-A-DP-1 [196.049880] Dynamic subtest pipe-A-DP-1: SUCCESS (1.805s) [196.063761] Starting dynamic subtest: pipe-B-DP-3 [197.878138] Dynamic subtest pipe-B-DP-3: SUCCESS (1.822s) [197.901083] Starting dynamic subtest: pipe-C-DP-1 [199.337458] Dynamic subtest pipe-C-DP-1: SUCCESS (1.451s) [199.338484] Subtest hang-read-crc: SUCCESS (5.098s) [199.837210] [116/165] (805s left) kms_pipe_crc_basic (nonblocking-crc) [200.313265] Starting subtest: nonblocking-crc [200.316110] Starting dynamic subtest: pipe-A-DP-1 [201.533648] Dynamic subtest pipe-A-DP-1: SUCCESS (1.217s) [201.550069] Starting dynamic subtest: pipe-B-DP-3 [202.610552] Dynamic subtest pipe-B-DP-3: SUCCESS (1.067s) [202.659821] Starting dynamic subtest: pipe-C-DP-1 [203.500324] Dynamic subtest pipe-C-DP-1: SUCCESS (0.872s) [203.502076] Subtest nonblocking-crc: SUCCESS (3.182s) [204.038365] [117/165] (801s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [204.529379] Starting subtest: nonblocking-crc-frame-sequence [204.531604] Starting dynamic subtest: pipe-A-DP-1 [205.841998] Dynamic subtest pipe-A-DP-1: SUCCESS (1.305s) [205.854607] Starting dynamic subtest: pipe-B-DP-3 [206.878334] Dynamic subtest pipe-B-DP-3: SUCCESS (1.032s) [206.925247] Starting dynamic subtest: pipe-C-DP-1 [207.727939] Dynamic subtest pipe-C-DP-1: SUCCESS (0.833s) [207.729041] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.200s) [208.273217] [118/165] (797s left) kms_pipe_crc_basic (read-crc) [208.748370] Starting subtest: read-crc [208.751553] Starting dynamic subtest: pipe-A-DP-1 [209.930653] Dynamic subtest pipe-A-DP-1: SUCCESS (1.178s) [209.948449] Starting dynamic subtest: pipe-B-DP-3 [211.450957] Dynamic subtest pipe-B-DP-3: SUCCESS (1.516s) [211.466486] Starting dynamic subtest: pipe-C-DP-1 [212.219073] Dynamic subtest pipe-C-DP-1: SUCCESS (0.761s) [212.220166] Subtest read-crc: SUCCESS (3.472s) [212.745971] [119/165] (793s left) kms_pipe_crc_basic (read-crc-frame-sequence) [213.238116] Starting subtest: read-crc-frame-sequence [213.241247] Starting dynamic subtest: pipe-A-DP-1 [214.353356] Dynamic subtest pipe-A-DP-1: SUCCESS (1.113s) [214.370730] Starting dynamic subtest: pipe-B-DP-3 [215.276454] Dynamic subtest pipe-B-DP-3: SUCCESS (0.910s) [215.323532] Starting dynamic subtest: pipe-C-DP-1 [216.062360] Dynamic subtest pipe-C-DP-1: SUCCESS (0.777s) [216.063311] Subtest read-crc-frame-sequence: SUCCESS (2.825s) [216.610891] [120/165] (789s left) kms_pm_backlight (basic-brightness) [217.096955] Subtest basic-brightness: SKIP (0.000s) [217.146029] [121/165] (788s left) kms_pm_rpm (basic-pci-d3-state) [219.327770] Starting subtest: basic-pci-d3-state [220.113507] Subtest basic-pci-d3-state: SUCCESS (0.781s) [220.989220] [122/165] (785s left) kms_pm_rpm (basic-rte) [221.067754] Starting subtest: basic-rte [224.078356] Subtest basic-rte: SUCCESS (3.008s) [225.404090] [123/165] (780s left) kms_psr (psr-primary-page-flip) [225.903500] Subtest psr-primary-page-flip: SKIP (0.000s) [225.949520] [124/165] (780s left) kms_psr (psr-cursor-plane-move) [226.432332] Subtest psr-cursor-plane-move: SKIP (0.000s) [226.475718] [125/165] (779s left) kms_psr (psr-sprite-plane-onoff) [226.972808] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [227.007863] [126/165] (779s left) kms_psr (psr-primary-mmap-gtt) [227.522220] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [227.556882] [127/165] (778s left) kms_setmode (basic-clone-single-crtc) [227.629119] Starting subtest: basic-clone-single-crtc [227.952708] Subtest basic-clone-single-crtc: SKIP (0.323s) [228.455416] [128/165] (777s left) i915_pm_rps (basic-api) [228.533588] Starting subtest: basic-api [228.537148] Subtest basic-api: SUCCESS (0.004s) [228.607969] [129/165] (777s left) prime_self_import (basic-llseek-bad) [228.666079] Starting subtest: basic-llseek-bad [228.668957] Subtest basic-llseek-bad: SUCCESS (0.002s) [228.740090] [130/165] (777s left) prime_self_import (basic-llseek-size) [228.800138] Starting subtest: basic-llseek-size [228.801290] Subtest basic-llseek-size: SUCCESS (0.003s) [228.884241] [131/165] (777s left) prime_self_import (basic-with_fd_dup) [228.955710] Starting subtest: basic-with_fd_dup [228.959667] Subtest basic-with_fd_dup: SUCCESS (0.002s) [229.053202] [132/165] (777s left) prime_self_import (basic-with_one_bo) [229.127719] Starting subtest: basic-with_one_bo [229.128854] Subtest basic-with_one_bo: SUCCESS (0.002s) [229.180359] [133/165] (777s left) prime_self_import (basic-with_one_bo_two_files) [229.233246] Starting subtest: basic-with_one_bo_two_files [229.234587] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [229.313585] [134/165] (777s left) prime_self_import (basic-with_two_bos) [229.373135] Starting subtest: basic-with_two_bos [229.374654] Subtest basic-with_two_bos: SUCCESS (0.003s) [229.471193] [135/165] (776s left) prime_vgem (basic-fence-flip) [229.551952] Starting subtest: basic-fence-flip [230.437114] Subtest basic-fence-flip: SUCCESS (0.882s) [230.554878] [136/165] (775s left) prime_vgem (basic-fence-mmap) [230.645569] Starting subtest: basic-fence-mmap [230.672907] Subtest basic-fence-mmap: SUCCESS (0.027s) [230.742936] [137/165] (775s left) prime_vgem (basic-fence-read) [230.831899] Starting subtest: basic-fence-read [230.874754] Subtest basic-fence-read: SUCCESS (0.043s) [230.940084] [138/165] (775s left) prime_vgem (basic-gtt) [231.019826] Starting subtest: basic-gtt [231.031720] Subtest basic-gtt: SUCCESS (0.012s) [231.144758] [139/165] (775s left) prime_vgem (basic-read) [231.240397] Starting subtest: basic-read [231.259918] Subtest basic-read: SUCCESS (0.019s) [231.372255] [140/165] (775s left) prime_vgem (basic-write) [231.462212] Starting subtest: basic-write [231.482431] Subtest basic-write: SUCCESS (0.022s) [231.561398] [141/165] (774s left) vgem_basic (setversion) [231.638652] Starting subtest: setversion [231.642846] Subtest setversion: SUCCESS (0.000s) [231.712679] [142/165] (774s left) vgem_basic (create) [231.788447] Starting subtest: create [231.789132] Subtest create: SUCCESS (0.000s) [231.839849] [143/165] (774s left) vgem_basic (debugfs) [231.905572] Starting subtest: debugfs [231.906162] Subtest debugfs: SUCCESS (0.000s) [231.956904] [144/165] (774s left) vgem_basic (dmabuf-export) [232.025542] Starting subtest: dmabuf-export [232.040256] Subtest dmabuf-export: SUCCESS (0.011s) [232.153444] [145/165] (774s left) vgem_basic (dmabuf-fence) [232.222291] Starting subtest: dmabuf-fence [232.223133] Subtest dmabuf-fence: SUCCESS (0.001s) [232.273691] [146/165] (774s left) vgem_basic (dmabuf-fence-before) [232.338742] Starting subtest: dmabuf-fence-before [232.341287] Subtest dmabuf-fence-before: SUCCESS (0.000s) [232.387378] [147/165] (774s left) vgem_basic (dmabuf-mmap) [232.457174] Starting subtest: dmabuf-mmap [232.468758] Subtest dmabuf-mmap: SUCCESS (0.013s) [232.526971] [148/165] (774s left) vgem_basic (mmap) [232.601713] Starting subtest: mmap [232.610113] Subtest mmap: SUCCESS (0.009s) [232.655800] [149/165] (774s left) vgem_basic (second-client) [232.721983] Starting subtest: second-client [232.755685] Subtest second-client: SUCCESS (0.033s) [232.828492] [150/165] (773s left) vgem_basic (sysfs) [232.905619] Starting subtest: sysfs [232.906295] Subtest sysfs: SUCCESS (0.001s) [232.980728] [151/165] (773s left) core_hotunplug (unbind-rebind) [233.088743] Starting subtest: unbind-rebind [237.447360] Subtest unbind-rebind: SUCCESS (4.356s) [237.478551] [152/165] (769s left) vgem_basic (unload) [237.564122] Starting subtest: unload [266.698821] Subtest unload: SUCCESS (29.134s) [266.830038] [153/165] (739s left) i915_module_load (reload) [266.888800] Starting subtest: reload [271.193626] Subtest reload: SUCCESS (4.305s) [271.214033] [154/165] (735s left) gem_lmem_swapping (basic) [271.281071] Subtest basic: SKIP (0.000s) [271.306682] [155/165] (735s left) gem_lmem_swapping (parallel-random-engines) [271.363669] Subtest parallel-random-engines: SKIP (0.000s) [271.389830] [156/165] (735s left) gem_lmem_swapping (random-engines) [271.447962] Subtest random-engines: SKIP (0.000s) [271.473539] [157/165] (735s left) gem_lmem_swapping (verify-random) [271.531689] Subtest verify-random: SKIP (0.000s) [271.556545] [158/165] (735s left) i915_pm_rpm (module-reload) [274.373218] Starting subtest: module-reload [286.464269] Subtest module-reload: SUCCESS (12.095s) [286.489442] [159/165] (720s left) i915_selftest (live) [286.560482] Starting subtest: live [286.561117] Starting dynamic subtest: sanitycheck [287.830632] Dynamic subtest sanitycheck: SUCCESS (1.271s) [287.839789] Starting dynamic subtest: uncore [289.104092] Dynamic subtest uncore: SUCCESS (1.270s) [289.109961] Starting dynamic subtest: workarounds [290.584553] Dynamic subtest workarounds: SUCCESS (1.480s) [290.595499] Starting dynamic subtest: gt_engines [292.371729] Dynamic subtest gt_engines: SUCCESS (1.785s) [292.379250] Starting dynamic subtest: gt_timelines [304.368153] Dynamic subtest gt_timelines: SUCCESS (11.993s) [304.373976] Starting dynamic subtest: gt_contexts [305.742259] Dynamic subtest gt_contexts: SUCCESS (1.370s) [305.748225] Starting dynamic subtest: gt_lrc [310.145625] Dynamic subtest gt_lrc: SUCCESS (4.405s) [310.151986] Starting dynamic subtest: gt_mocs [311.479550] Dynamic subtest gt_mocs: SUCCESS (1.332s) [311.486497] Starting dynamic subtest: gt_pm [318.622437] Dynamic subtest gt_pm: SUCCESS (7.142s) [318.629079] Starting dynamic subtest: gt_heartbeat [320.026172] Dynamic subtest gt_heartbeat: SUCCESS (1.400s) [320.032506] Starting dynamic subtest: gt_tlb [322.586654] Dynamic subtest gt_tlb: SUCCESS (2.560s) [322.593807] Starting dynamic subtest: requests [331.354676] Dynamic subtest requests: SUCCESS (8.766s) [331.362767] Starting dynamic subtest: migrate [335.409458] Dynamic subtest migrate: SUCCESS (4.053s) [335.417708] Starting dynamic subtest: active [336.713750] Dynamic subtest active: SUCCESS (1.302s) [336.723743] Starting dynamic subtest: objects [338.880192] Dynamic subtest objects: SUCCESS (2.163s) [338.888076] Starting dynamic subtest: mman [343.959963] Dynamic subtest mman: SUCCESS (5.079s) [343.970072] Starting dynamic subtest: dmabuf [345.301699] Dynamic subtest dmabuf: SUCCESS (1.340s) [345.309785] Starting dynamic subtest: vma [346.546458] Dynamic subtest vma: SUCCESS (1.243s) [346.553872] Starting dynamic subtest: coherency [348.840578] Dynamic subtest coherency: SUCCESS (2.292s) [348.848618] Starting dynamic subtest: gtt [357.551604] Dynamic subtest gtt: SUCCESS (8.710s) [357.559487] Starting dynamic subtest: gem [358.981750] Dynamic subtest gem: SUCCESS (1.428s) [358.991079] Starting dynamic subtest: evict [361.699475] Dynamic subtest evict: SUCCESS (2.716s) [361.706818] Starting dynamic subtest: hugepages [368.900848] Dynamic subtest hugepages: SUCCESS (7.199s) [368.910321] Starting dynamic subtest: gem_contexts [385.782789] Dynamic subtest gem_contexts: SUCCESS (16.880s) [385.791736] Starting dynamic subtest: client [387.094139] Dynamic subtest client: SUCCESS (1.308s) [387.101854] Starting dynamic subtest: gem_migrate [388.358698] Dynamic subtest gem_migrate: SUCCESS (1.264s) [388.366203] Starting dynamic subtest: reset [390.269492] Dynamic subtest reset: SUCCESS (1.909s) [390.276074] Starting dynamic subtest: memory_region [391.540647] Dynamic subtest memory_region: SUCCESS (1.270s) [391.548183] Starting dynamic subtest: hangcheck [421.327363] Dynamic subtest hangcheck: SUCCESS (29.785s) [421.336517] Starting dynamic subtest: execlists [434.955613] Dynamic subtest execlists: SUCCESS (13.626s) [434.963857] Starting dynamic subtest: ring_submission [436.227729] Dynamic subtest ring_submission: SUCCESS (1.270s) [436.237299] Starting dynamic subtest: perf [437.642759] Dynamic subtest perf: SUCCESS (1.413s) [437.652208] Starting dynamic subtest: slpc [438.907715] Dynamic subtest slpc: SUCCESS (1.263s) [438.915102] Starting dynamic subtest: guc [440.157534] Dynamic subtest guc: SUCCESS (1.248s) [440.164812] Starting dynamic subtest: guc_multi_lrc [441.359818] Dynamic subtest guc_multi_lrc: SUCCESS (1.201s) [441.368029] Starting dynamic subtest: guc_hang [442.629156] Dynamic subtest guc_hang: SUCCESS (1.266s) [442.636051] Starting dynamic subtest: late_gt_pm [443.961172] Dynamic subtest late_gt_pm: SUCCESS (1.330s) [443.961812] Subtest live: SUCCESS (157.401s) [443.980454] [160/165] (562s left) dmabuf (all-tests) [444.043670] Starting subtest: all-tests [444.047511] Starting dynamic subtest: sanitycheck [444.115856] Dynamic subtest sanitycheck: SUCCESS (0.072s) [444.144863] Starting dynamic subtest: dma_fence [444.308086] Dynamic subtest dma_fence: SUCCESS (0.187s) [444.314850] Starting dynamic subtest: dma_fence_chain [458.920245] Dynamic subtest dma_fence_chain: SUCCESS (14.611s) [458.933097] Starting dynamic subtest: dma_fence_unwrap [458.990490] Dynamic subtest dma_fence_unwrap: SUCCESS (0.067s) [459.020198] Starting dynamic subtest: dma_resv [459.080593] Dynamic subtest dma_resv: SUCCESS (0.083s) [459.090371] Subtest all-tests: SUCCESS (15.041s) [459.125881] [161/165] (547s left) i915_suspend (basic-s2idle-without-i915) [459.188914] Starting subtest: basic-s2idle-without-i915 [480.225552] Subtest basic-s2idle-without-i915: SUCCESS (6.486s) [483.177570] [162/165] (540s left) i915_suspend (basic-s3-without-i915) [483.238320] Starting subtest: basic-s3-without-i915 [503.491218] Subtest basic-s3-without-i915: SUCCESS (4.213s) [506.555215] [163/165] (535s left) gem_exec_suspend (basic-s0) [506.651455] Starting subtest: basic-S0 [506.652124] Starting dynamic subtest: smem [524.993369] Dynamic subtest smem: SUCCESS (3.680s) [524.994116] Subtest basic-S0: SUCCESS (3.682s) [528.165300] [164/165] (531s left) gem_exec_suspend (basic-s3) [528.234099] Starting subtest: basic-S3 [528.235808] Starting dynamic subtest: smem [548.093051] Dynamic subtest smem: SUCCESS (3.842s) [548.093902] Subtest basic-S3: SUCCESS (3.843s) [551.286760] [165/165] (527s left) kms_pipe_crc_basic (suspend-read-crc) [551.790719] Starting subtest: suspend-read-crc [551.792359] Starting dynamic subtest: pipe-A-DP-1 [571.873923] Dynamic subtest pipe-A-DP-1: SUCCESS (3.687s) [571.886989] Starting dynamic subtest: pipe-B-DP-3 [591.970665] Dynamic subtest pipe-B-DP-3: SUCCESS (3.383s) [591.990292] Starting dynamic subtest: pipe-C-DP-1 [611.857247] Dynamic subtest pipe-C-DP-1: SUCCESS (3.201s) [611.857881] Subtest suspend-read-crc: SUCCESS (10.290s) [616.337567] Closing watchdogs Done.