[43.113494] Initializing watchdogs [43.113578] /dev/watchdog0 [43.121468] [001/165] (960s left) i915_module_load (load) [43.200704] Starting subtest: load [45.393360] Subtest load: SUCCESS (2.191s) [45.412883] [002/165] (958s left) core_auth (basic-auth) [45.533025] Starting subtest: basic-auth [45.536854] Subtest basic-auth: SUCCESS (0.004s) [45.607776] [003/165] (958s left) debugfs_test (read_all_entries) [45.684279] Starting subtest: read_all_entries [45.825597] Subtest read_all_entries: SUCCESS (0.140s) [46.126806] [004/165] (957s left) debugfs_test (basic-hwmon) [46.210030] Starting subtest: basic-hwmon [46.217282] Subtest basic-hwmon: SKIP (0.000s) [46.492611] [005/165] (957s left) fbdev (eof) [46.574118] Starting subtest: eof [46.577671] Subtest eof: SUCCESS (0.001s) [46.626415] [006/165] (957s left) fbdev (info) [46.696375] Starting subtest: info [46.699996] Subtest info: SUCCESS (0.000s) [46.778363] [007/165] (956s left) fbdev (nullptr) [46.873799] Starting subtest: nullptr [46.877693] Subtest nullptr: SUCCESS (0.000s) [46.927322] [008/165] (956s left) fbdev (read) [47.007598] Starting subtest: read [47.273134] Subtest read: SUCCESS (0.266s) [47.332220] [009/165] (956s left) fbdev (write) [47.437451] Starting subtest: write [47.572470] Subtest write: SUCCESS (0.135s) [47.625125] [010/165] (956s left) gem_basic (bad-close) [47.724819] Starting subtest: bad-close [47.731810] Subtest bad-close: SUCCESS (0.000s) [47.805076] [011/165] (956s left) gem_basic (create-close) [47.894195] Starting subtest: create-close [47.901079] Subtest create-close: SUCCESS (0.000s) [47.994675] [012/165] (955s left) gem_basic (create-fd-close) [48.075594] Starting subtest: create-fd-close [48.082373] Subtest create-fd-close: SUCCESS (0.000s) [48.171742] [013/165] (955s left) gem_busy (busy@all-engines) [48.276492] Starting subtest: busy [48.280067] Starting dynamic subtest: all-engines [48.347282] Dynamic subtest all-engines: SUCCESS (0.071s) [48.350765] Subtest busy: SUCCESS (0.071s) [48.749650] [014/165] (955s left) gem_close_race (basic-process) [48.860353] Starting subtest: basic-process [48.915971] Subtest basic-process: SUCCESS (0.055s) [49.108077] [015/165] (954s left) gem_close_race (basic-threads) [49.192389] Starting subtest: basic-threads [50.463945] Subtest basic-threads: SUCCESS (1.199s) [50.888650] [016/165] (953s left) gem_ctx_create (basic) [51.347906] Starting subtest: basic [51.414352] Subtest basic: SUCCESS (0.000s) [51.643952] [017/165] (952s left) gem_ctx_create (basic-files) [51.789821] Starting subtest: basic-files [53.810130] Subtest basic-files: SUCCESS (2.020s) [54.052378] [018/165] (950s left) gem_ctx_exec (basic) [54.123479] Starting subtest: basic [54.126832] Subtest basic: SUCCESS (0.003s) [54.238607] [019/165] (950s left) gem_exec_basic (basic) [54.324683] Starting subtest: basic [54.327832] Starting dynamic subtest: rcs0-smem [54.331019] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [54.339574] Starting dynamic subtest: bcs0-smem [54.343226] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [54.351637] Starting dynamic subtest: vcs0-smem [54.354937] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [54.363202] Starting dynamic subtest: vcs1-smem [54.366390] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [54.374615] Starting dynamic subtest: vecs0-smem [54.377915] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [54.381276] Subtest basic: SUCCESS (0.004s) [54.554362] [020/165] (950s left) gem_exec_create (basic) [54.655140] Starting subtest: basic [54.658582] Starting dynamic subtest: smem [56.697473] Dynamic subtest smem: SUCCESS (2.042s) [56.700888] Subtest basic: SUCCESS (2.042s) [56.906765] [021/165] (947s left) gem_exec_fence (basic-busy) [57.152493] Starting subtest: basic-busy [57.156702] Starting dynamic subtest: rcs0 [57.178318] Dynamic subtest rcs0: SUCCESS (0.027s) [57.195730] Starting dynamic subtest: bcs0 [57.206186] Dynamic subtest bcs0: SUCCESS (0.028s) [57.214941] Starting dynamic subtest: vcs0 [57.230307] Dynamic subtest vcs0: SUCCESS (0.025s) [57.240598] Starting dynamic subtest: vcs1 [57.252345] Dynamic subtest vcs1: SUCCESS (0.022s) [57.261296] Starting dynamic subtest: vecs0 [57.281351] Dynamic subtest vecs0: SUCCESS (0.029s) [57.284687] Subtest basic-busy: SUCCESS (0.132s) [57.934617] [022/165] (946s left) gem_exec_fence (basic-wait) [58.161989] Starting subtest: basic-wait [58.166049] Starting dynamic subtest: rcs0 [58.199986] Dynamic subtest rcs0: SUCCESS (0.038s) [58.217084] Starting dynamic subtest: bcs0 [58.228274] Dynamic subtest bcs0: SUCCESS (0.027s) [58.245821] Starting dynamic subtest: vcs0 [58.255552] Dynamic subtest vcs0: SUCCESS (0.026s) [58.271614] Starting dynamic subtest: vcs1 [58.282317] Dynamic subtest vcs1: SUCCESS (0.027s) [58.292750] Starting dynamic subtest: vecs0 [58.306222] Dynamic subtest vecs0: SUCCESS (0.026s) [58.309880] Subtest basic-wait: SUCCESS (0.145s) [58.949758] [023/165] (945s left) gem_exec_fence (basic-await) [59.185246] Starting subtest: basic-await [59.189044] Starting dynamic subtest: rcs0 [59.290224] Dynamic subtest rcs0: SUCCESS (0.112s) [59.301611] Starting dynamic subtest: bcs0 [59.399462] Dynamic subtest bcs0: SUCCESS (0.109s) [59.410379] Starting dynamic subtest: vcs0 [59.502421] Dynamic subtest vcs0: SUCCESS (0.103s) [59.512225] Starting dynamic subtest: vcs1 [59.606142] Dynamic subtest vcs1: SUCCESS (0.102s) [59.617889] Starting dynamic subtest: vecs0 [59.715178] Dynamic subtest vecs0: SUCCESS (0.110s) [59.718389] Subtest basic-await: SUCCESS (0.538s) [60.334042] [024/165] (944s left) gem_exec_fence (nb-await) [60.574642] Starting subtest: nb-await [60.577827] Starting dynamic subtest: rcs0 [60.641519] Dynamic subtest rcs0: SUCCESS (0.067s) [60.654655] Starting dynamic subtest: bcs0 [60.712264] Dynamic subtest bcs0: SUCCESS (0.067s) [60.729511] Starting dynamic subtest: vcs0 [60.786320] Dynamic subtest vcs0: SUCCESS (0.074s) [60.803505] Starting dynamic subtest: vcs1 [60.858329] Dynamic subtest vcs1: SUCCESS (0.073s) [60.877334] Starting dynamic subtest: vecs0 [60.930764] Dynamic subtest vecs0: SUCCESS (0.072s) [60.934419] Subtest nb-await: SUCCESS (0.356s) [61.572528] [025/165] (943s left) gem_exec_gttfill (basic) [61.669989] Starting subtest: basic [66.160350] Subtest basic: SUCCESS (4.492s) [66.341801] [026/165] (938s left) gem_exec_parallel (engines) [66.499617] Starting subtest: engines [66.503139] Starting dynamic subtest: basic [68.473342] Dynamic subtest basic: SUCCESS (1.974s) [68.482235] Starting dynamic subtest: contexts [74.075320] Dynamic subtest contexts: SUCCESS (5.601s) [74.084476] Starting dynamic subtest: fds [79.073700] Dynamic subtest fds: SUCCESS (4.999s) [79.091914] Starting dynamic subtest: userptr [81.145067] Dynamic subtest userptr: SUCCESS (2.072s) [81.148399] Subtest engines: SUCCESS (14.647s) [81.350648] [027/165] (923s left) gem_exec_store (basic) [81.468085] Starting subtest: basic [81.513930] Subtest basic: SUCCESS (0.051s) [81.906454] [028/165] (923s left) gem_flink_basic (bad-flink) [82.330234] Starting subtest: bad-flink [82.395749] Subtest bad-flink: SUCCESS (0.000s) [82.657142] [029/165] (922s left) gem_flink_basic (bad-open) [83.080338] Starting subtest: bad-open [83.085834] Subtest bad-open: SUCCESS (0.000s) [83.126877] [030/165] (922s left) gem_flink_basic (basic) [83.214188] Starting subtest: basic [83.218155] Subtest basic: SUCCESS (0.000s) [83.315543] [031/165] (921s left) gem_flink_basic (double-flink) [83.382424] Starting subtest: double-flink [83.385771] Subtest double-flink: SUCCESS (0.000s) [83.486907] [032/165] (921s left) gem_flink_basic (flink-lifetime) [83.571773] Starting subtest: flink-lifetime [83.575170] Subtest flink-lifetime: SUCCESS (0.002s) [83.648904] [033/165] (921s left) gem_huc_copy (huc-copy) [83.740301] Starting subtest: huc-copy [83.746938] Subtest huc-copy: SKIP (0.000s) [83.873095] [034/165] (921s left) gem_linear_blits (basic) [84.055335] Starting subtest: basic [84.067951] Subtest basic: SUCCESS (0.012s) [84.219448] [035/165] (921s left) gem_mmap (basic) [84.410087] Starting subtest: basic [84.426470] Subtest basic: SUCCESS (0.000s) [84.512170] [036/165] (920s left) gem_mmap_gtt (basic) [84.583019] Starting subtest: basic [84.586571] Subtest basic: SUCCESS (0.001s) [84.634868] [037/165] (920s left) gem_render_linear_blits (basic) [84.728897] Starting subtest: basic [84.763412] Subtest basic: SUCCESS (0.032s) [84.811509] [038/165] (920s left) gem_render_tiled_blits (basic) [84.898316] Starting subtest: basic [84.936291] Subtest basic: SUCCESS (0.036s) [84.984683] [039/165] (920s left) gem_ringfill (basic-all) [85.329552] Starting subtest: basic-all [86.499488] Subtest basic-all: SUCCESS (1.172s) [86.616970] [040/165] (919s left) gem_softpin (allocator-basic) [86.712988] Starting subtest: allocator-basic [86.820238] Subtest allocator-basic: SUCCESS (0.109s) [86.917188] [041/165] (918s left) gem_softpin (allocator-basic-reserve) [86.999374] Starting subtest: allocator-basic-reserve [87.102023] Subtest allocator-basic-reserve: SUCCESS (0.107s) [87.195937] [042/165] (918s left) gem_softpin (safe-alignment) [87.276508] Starting subtest: safe-alignment [87.290343] Subtest safe-alignment: SUCCESS (0.013s) [87.403530] [043/165] (918s left) gem_sync (basic-all) [87.522120] Starting subtest: basic-all [89.809180] Subtest basic-all: SUCCESS (2.308s) [90.017994] [044/165] (915s left) gem_sync (basic-each) [90.116297] Starting subtest: basic-each [92.325157] Subtest basic-each: SUCCESS (2.230s) [92.537959] [045/165] (913s left) gem_tiled_blits (basic) [92.740963] Starting subtest: basic [92.763452] Subtest basic: SUCCESS (0.022s) [92.926819] [046/165] (912s left) gem_tiled_fence_blits (basic) [93.201468] Starting subtest: basic [93.212514] Subtest basic: SUCCESS (0.010s) [93.369388] [047/165] (912s left) gem_tiled_pread_basic [93.717844] [048/165] (912s left) gem_wait (busy@all-engines) [93.819328] Starting subtest: busy [93.823267] Starting dynamic subtest: all-engines [94.349333] Dynamic subtest all-engines: SUCCESS (0.530s) [94.352522] Subtest busy: SUCCESS (0.530s) [94.580571] [049/165] (911s left) gem_wait (wait@all-engines) [94.674935] Starting subtest: wait [94.678141] Starting dynamic subtest: all-engines [95.709267] Dynamic subtest all-engines: SUCCESS (1.033s) [95.713182] Subtest wait: SUCCESS (1.034s) [95.950105] [050/165] (910s left) i915_getparams_basic (basic-eu-total) [96.021294] Starting subtest: basic-eu-total [96.028181] Subtest basic-eu-total: SUCCESS (0.000s) [96.100220] [051/165] (909s left) i915_getparams_basic (basic-subslice-total) [96.187425] Starting subtest: basic-subslice-total [96.194177] Subtest basic-subslice-total: SUCCESS (0.000s) [96.242589] [052/165] (909s left) i915_hangman (error-state-basic) [96.316761] Starting subtest: error-state-basic [96.330034] Subtest error-state-basic: SUCCESS (0.009s) [96.392346] [053/165] (909s left) i915_pciid [96.552136] [054/165] (909s left) kms_addfb_basic (addfb25-4-tiled) [96.855125] Starting subtest: addfb25-4-tiled [96.858276] Subtest addfb25-4-tiled: SUCCESS (0.000s) [96.927606] [055/165] (909s left) kms_addfb_basic (addfb25-bad-modifier) [97.004400] Starting subtest: addfb25-bad-modifier [97.007598] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [97.292619] [056/165] (908s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [97.359871] Starting subtest: addfb25-framebuffer-vs-set-tiling [97.362848] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [97.655471] [057/165] (908s left) kms_addfb_basic (addfb25-modifier-no-flag) [97.743680] Starting subtest: addfb25-modifier-no-flag [97.746888] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [98.029556] [058/165] (908s left) kms_addfb_basic (addfb25-x-tiled-legacy) [98.110497] Starting subtest: addfb25-x-tiled-legacy [98.113750] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [98.418384] [059/165] (907s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [98.515490] Starting subtest: addfb25-x-tiled-mismatch-legacy [98.518557] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [98.815749] [060/165] (907s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [99.116620] Starting subtest: addfb25-yf-tiled-legacy [99.119389] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [99.196309] [061/165] (907s left) kms_addfb_basic (addfb25-y-tiled-legacy) [99.488612] Starting subtest: addfb25-y-tiled-legacy [99.491205] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [99.562807] [062/165] (906s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [99.851564] Starting subtest: addfb25-y-tiled-small-legacy [99.854378] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [99.929361] [063/165] (906s left) kms_addfb_basic (bad-pitch-0) [100.010068] Starting subtest: bad-pitch-0 [100.013569] Subtest bad-pitch-0: SUCCESS (0.000s) [100.297113] [064/165] (906s left) kms_addfb_basic (bad-pitch-1024) [100.383622] Starting subtest: bad-pitch-1024 [100.387142] Subtest bad-pitch-1024: SUCCESS (0.000s) [100.698877] [065/165] (905s left) kms_addfb_basic (bad-pitch-128) [100.788258] Starting subtest: bad-pitch-128 [100.792097] Subtest bad-pitch-128: SUCCESS (0.000s) [101.092453] [066/165] (905s left) kms_addfb_basic (bad-pitch-256) [101.162281] Starting subtest: bad-pitch-256 [101.165640] Subtest bad-pitch-256: SUCCESS (0.000s) [101.461953] [067/165] (904s left) kms_addfb_basic (bad-pitch-32) [101.539638] Starting subtest: bad-pitch-32 [101.543108] Subtest bad-pitch-32: SUCCESS (0.000s) [101.826720] [068/165] (904s left) kms_addfb_basic (bad-pitch-63) [101.898767] Starting subtest: bad-pitch-63 [101.901835] Subtest bad-pitch-63: SUCCESS (0.000s) [102.194314] [069/165] (904s left) kms_addfb_basic (bad-pitch-65536) [102.268864] Starting subtest: bad-pitch-65536 [102.272282] Subtest bad-pitch-65536: SUCCESS (0.000s) [102.563112] [070/165] (903s left) kms_addfb_basic (bad-pitch-999) [102.643064] Starting subtest: bad-pitch-999 [102.646711] Subtest bad-pitch-999: SUCCESS (0.000s) [102.948058] [071/165] (903s left) kms_addfb_basic (basic) [103.030969] Starting subtest: basic [103.034064] Subtest basic: SUCCESS (0.000s) [103.325987] [072/165] (903s left) kms_addfb_basic (basic-x-tiled-legacy) [103.395583] Starting subtest: basic-x-tiled-legacy [103.399115] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [103.678993] [073/165] (902s left) kms_addfb_basic (basic-y-tiled-legacy) [103.754455] Starting subtest: basic-y-tiled-legacy [103.757786] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [104.064362] [074/165] (902s left) kms_addfb_basic (bo-too-small) [104.357506] Starting subtest: bo-too-small [104.360276] Subtest bo-too-small: SUCCESS (0.000s) [104.425859] [075/165] (902s left) kms_addfb_basic (bo-too-small-due-to-tiling) [104.717969] Starting subtest: bo-too-small-due-to-tiling [104.720933] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [104.796228] [076/165] (901s left) kms_addfb_basic (clobberred-modifier) [104.874807] Starting subtest: clobberred-modifier [104.878080] Subtest clobberred-modifier: SUCCESS (0.000s) [105.163920] [077/165] (901s left) kms_addfb_basic (framebuffer-vs-set-tiling) [105.242803] Starting subtest: framebuffer-vs-set-tiling [105.245879] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [105.551289] [078/165] (901s left) kms_addfb_basic (invalid-get-prop) [105.641266] Starting subtest: invalid-get-prop [105.644299] Subtest invalid-get-prop: SUCCESS (0.000s) [105.955687] [079/165] (900s left) kms_addfb_basic (invalid-get-prop-any) [106.046188] Starting subtest: invalid-get-prop-any [106.049444] Subtest invalid-get-prop-any: SUCCESS (0.000s) [106.345259] [080/165] (900s left) kms_addfb_basic (invalid-set-prop) [106.421199] Starting subtest: invalid-set-prop [106.424609] Subtest invalid-set-prop: SUCCESS (0.000s) [106.715566] [081/165] (900s left) kms_addfb_basic (invalid-set-prop-any) [106.800207] Starting subtest: invalid-set-prop-any [106.803565] Subtest invalid-set-prop-any: SUCCESS (0.000s) [107.092884] [082/165] (899s left) kms_addfb_basic (no-handle) [107.164703] Starting subtest: no-handle [107.167964] Subtest no-handle: SUCCESS (0.000s) [107.462328] [083/165] (899s left) kms_addfb_basic (size-max) [107.745960] Starting subtest: size-max [107.748643] Subtest size-max: SUCCESS (0.000s) [107.826941] [084/165] (899s left) kms_addfb_basic (small-bo) [108.111086] Starting subtest: small-bo [108.113877] Subtest small-bo: SUCCESS (0.000s) [108.201466] [085/165] (898s left) kms_addfb_basic (tile-pitch-mismatch) [108.291151] Starting subtest: tile-pitch-mismatch [108.294367] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [108.591856] [086/165] (898s left) kms_addfb_basic (too-high) [108.904692] Starting subtest: too-high [108.907603] Subtest too-high: SUCCESS (0.001s) [108.996444] [087/165] (897s left) kms_addfb_basic (too-wide) [109.286962] Starting subtest: too-wide [109.290057] Subtest too-wide: SUCCESS (0.000s) [109.362715] [088/165] (897s left) kms_addfb_basic (unused-handle) [109.440059] Starting subtest: unused-handle [109.442929] Subtest unused-handle: SUCCESS (0.000s) [109.754656] [089/165] (897s left) kms_addfb_basic (unused-modifier) [109.851236] Starting subtest: unused-modifier [109.854374] Subtest unused-modifier: SUCCESS (0.000s) [110.146411] [090/165] (896s left) kms_addfb_basic (unused-offsets) [110.220325] Starting subtest: unused-offsets [110.223449] Subtest unused-offsets: SUCCESS (0.000s) [110.535438] [091/165] (896s left) kms_addfb_basic (unused-pitches) [110.623347] Starting subtest: unused-pitches [110.626499] Subtest unused-pitches: SUCCESS (0.000s) [110.934766] [092/165] (896s left) kms_busy (basic) [111.259222] Starting subtest: basic [111.262516] Starting dynamic subtest: flip [112.268024] Dynamic subtest flip: SUCCESS (0.904s) [112.332834] Starting dynamic subtest: modeset [113.428649] Dynamic subtest modeset: SUCCESS (1.108s) [113.432331] Subtest basic: SUCCESS (2.015s) [113.671391] [093/165] (893s left) kms_prop_blob (basic) [113.772841] Starting subtest: basic [113.776401] Subtest basic: SUCCESS (0.000s) [113.832606] [094/165] (893s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [114.124910] Starting subtest: basic-busy-flip-before-cursor-atomic [114.131233] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [114.208079] [095/165] (893s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [114.509758] Starting subtest: basic-busy-flip-before-cursor-legacy [114.515412] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [114.576276] [096/165] (892s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [114.865855] Starting subtest: basic-flip-after-cursor-atomic [116.008933] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.046s) [116.539465] [097/165] (890s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [116.830956] Starting subtest: basic-flip-after-cursor-legacy [117.859596] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.031s) [118.294591] [098/165] (889s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [118.584629] Starting subtest: basic-flip-after-cursor-varying-size [119.619181] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.033s) [120.028556] [099/165] (887s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [120.336784] Starting subtest: basic-flip-before-cursor-atomic [121.373488] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.036s) [121.816613] [100/165] (885s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [122.123177] Starting subtest: basic-flip-before-cursor-legacy [123.156918] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.034s) [123.593372] [101/165] (884s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [123.898127] Starting subtest: basic-flip-before-cursor-varying-size [124.901440] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.006s) [125.285168] [102/165] (882s left) kms_dsc (dsc-basic) [125.570556] Subtest dsc-basic: SKIP (0.000s) [125.596100] [103/165] (882s left) kms_flip (basic-flip-vs-dpms) [125.877206] Starting subtest: basic-flip-vs-dpms [125.880588] Starting dynamic subtest: A-DP1 [127.032787] Dynamic subtest A-DP1: SUCCESS (1.149s) [127.045204] Starting dynamic subtest: B-DP1 [128.061289] Dynamic subtest B-DP1: SUCCESS (1.026s) [128.075456] Starting dynamic subtest: C-DP1 [129.109819] Dynamic subtest C-DP1: SUCCESS (1.044s) [129.127376] Starting dynamic subtest: A-DP2 [130.066426] Dynamic subtest A-DP2: SUCCESS (0.952s) [130.088037] Starting dynamic subtest: B-DP2 [130.878433] Dynamic subtest B-DP2: SUCCESS (0.810s) [130.889720] Starting dynamic subtest: C-DP2 [131.638247] Dynamic subtest C-DP2: SUCCESS (0.758s) [131.641120] Subtest basic-flip-vs-dpms: SUCCESS (5.765s) [132.118112] [104/165] (875s left) kms_flip (basic-flip-vs-modeset) [132.439570] Starting subtest: basic-flip-vs-modeset [132.442338] Starting dynamic subtest: A-DP1 [133.593653] Dynamic subtest A-DP1: SUCCESS (1.151s) [133.608753] Starting dynamic subtest: B-DP1 [134.561209] Dynamic subtest B-DP1: SUCCESS (0.963s) [134.583478] Starting dynamic subtest: C-DP1 [135.576365] Dynamic subtest C-DP1: SUCCESS (1.012s) [135.596144] Starting dynamic subtest: A-DP2 [136.291581] Dynamic subtest A-DP2: SUCCESS (0.711s) [136.302553] Starting dynamic subtest: B-DP2 [137.025776] Dynamic subtest B-DP2: SUCCESS (0.727s) [137.037096] Starting dynamic subtest: C-DP2 [137.769197] Dynamic subtest C-DP2: SUCCESS (0.747s) [137.772230] Subtest basic-flip-vs-modeset: SUCCESS (5.335s) [138.236976] [105/165] (869s left) kms_flip (basic-flip-vs-wf_vblank) [138.534930] Starting subtest: basic-flip-vs-wf_vblank [138.537748] Starting dynamic subtest: A-DP1 [139.911061] Dynamic subtest A-DP1: SUCCESS (1.262s) [139.976718] Starting dynamic subtest: B-DP1 [140.997796] Dynamic subtest B-DP1: SUCCESS (1.107s) [141.062882] Starting dynamic subtest: C-DP1 [142.054327] Dynamic subtest C-DP1: SUCCESS (1.122s) [142.066092] Starting dynamic subtest: A-DP2 [143.074758] Dynamic subtest A-DP2: SUCCESS (1.039s) [143.086481] Starting dynamic subtest: B-DP2 [144.124423] Dynamic subtest B-DP2: SUCCESS (1.046s) [144.153915] Starting dynamic subtest: C-DP2 [145.218069] Dynamic subtest C-DP2: SUCCESS (1.090s) [145.221557] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.687s) [145.761961] [106/165] (862s left) kms_flip (basic-plain-flip) [146.063050] Starting subtest: basic-plain-flip [146.066048] Starting dynamic subtest: A-DP1 [146.974757] Dynamic subtest A-DP1: SUCCESS (0.907s) [146.987865] Starting dynamic subtest: B-DP1 [147.864142] Dynamic subtest B-DP1: SUCCESS (0.890s) [147.876245] Starting dynamic subtest: C-DP1 [148.734198] Dynamic subtest C-DP1: SUCCESS (0.866s) [148.744621] Starting dynamic subtest: A-DP2 [149.512999] Dynamic subtest A-DP2: SUCCESS (0.776s) [149.524478] Starting dynamic subtest: B-DP2 [150.270252] Dynamic subtest B-DP2: SUCCESS (0.754s) [150.288215] Starting dynamic subtest: C-DP2 [151.063817] Dynamic subtest C-DP2: SUCCESS (0.790s) [151.066974] Subtest basic-plain-flip: SUCCESS (5.003s) [151.614166] [107/165] (856s left) kms_force_connector_basic (force-connector-state) [151.768051] Starting subtest: force-connector-state [152.336082] Subtest force-connector-state: SUCCESS (0.564s) [153.164724] [108/165] (854s left) kms_force_connector_basic (force-edid) [153.292836] Starting subtest: force-edid [153.410270] Subtest force-edid: SUCCESS (0.113s) [153.932045] [109/165] (854s left) kms_force_connector_basic (force-load-detect) [154.064578] Starting subtest: force-load-detect [154.070162] Subtest force-load-detect: SKIP (0.000s) [154.384175] [110/165] (853s left) kms_force_connector_basic (prune-stale-modes) [154.511318] Starting subtest: prune-stale-modes [154.623410] Subtest prune-stale-modes: SUCCESS (0.108s) [155.131128] [111/165] (852s left) kms_frontbuffer_tracking (basic) [155.438711] Starting subtest: basic [158.288567] Subtest basic: SUCCESS (2.726s) [158.741075] [112/165] (849s left) kms_hdmi_inject (inject-audio) [159.347408] Starting subtest: inject-audio [159.618654] Subtest inject-audio: SUCCESS (0.169s) [160.297254] [113/165] (848s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [160.605146] Starting subtest: compare-crc-sanitycheck-xr24 [160.608452] Starting dynamic subtest: pipe-A-DP-1 [161.190836] Dynamic subtest pipe-A-DP-1: SUCCESS (0.587s) [161.211688] Starting dynamic subtest: pipe-B-DP-2 [161.693831] Dynamic subtest pipe-B-DP-2: SUCCESS (0.491s) [161.707276] Starting dynamic subtest: pipe-C-DP-1 [162.243332] Dynamic subtest pipe-C-DP-1: SUCCESS (0.546s) [162.247369] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.639s) [162.754245] [114/165] (845s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [163.063483] Starting subtest: compare-crc-sanitycheck-nv12 [163.066503] Starting dynamic subtest: pipe-A-DP-1 [163.691355] Dynamic subtest pipe-A-DP-1: SUCCESS (0.626s) [163.705325] Starting dynamic subtest: pipe-B-DP-2 [164.219899] Dynamic subtest pipe-B-DP-2: SUCCESS (0.514s) [164.233334] Starting dynamic subtest: pipe-C-DP-1 [164.239427] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [164.242562] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.154s) [164.613471] [115/165] (844s left) kms_pipe_crc_basic (hang-read-crc) [164.916140] Starting subtest: hang-read-crc [164.918909] Starting dynamic subtest: pipe-A-DP-1 [166.336393] Dynamic subtest pipe-A-DP-1: SUCCESS (1.336s) [166.400940] Starting dynamic subtest: pipe-B-DP-2 [167.524438] Dynamic subtest pipe-B-DP-2: SUCCESS (1.163s) [167.644933] Starting dynamic subtest: pipe-C-DP-1 [168.733678] Dynamic subtest pipe-C-DP-1: SUCCESS (1.310s) [168.736798] Subtest hang-read-crc: SUCCESS (3.819s) [169.152071] [116/165] (839s left) kms_pipe_crc_basic (nonblocking-crc) [169.454804] Starting subtest: nonblocking-crc [169.457769] Starting dynamic subtest: pipe-A-DP-1 [170.236586] Dynamic subtest pipe-A-DP-1: SUCCESS (0.778s) [170.250732] Starting dynamic subtest: pipe-B-DP-2 [170.883919] Dynamic subtest pipe-B-DP-2: SUCCESS (0.642s) [170.901317] Starting dynamic subtest: pipe-C-DP-1 [171.630349] Dynamic subtest pipe-C-DP-1: SUCCESS (0.741s) [171.634185] Subtest nonblocking-crc: SUCCESS (2.175s) [172.046877] [117/165] (836s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [172.348354] Starting subtest: nonblocking-crc-frame-sequence [172.351581] Starting dynamic subtest: pipe-A-DP-1 [173.102544] Dynamic subtest pipe-A-DP-1: SUCCESS (0.750s) [173.124535] Starting dynamic subtest: pipe-B-DP-2 [173.768174] Dynamic subtest pipe-B-DP-2: SUCCESS (0.659s) [173.788712] Starting dynamic subtest: pipe-C-DP-1 [174.496735] Dynamic subtest pipe-C-DP-1: SUCCESS (0.721s) [174.501787] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.147s) [174.933186] [118/165] (833s left) kms_pipe_crc_basic (read-crc) [175.242766] Starting subtest: read-crc [175.245620] Starting dynamic subtest: pipe-A-DP-1 [175.959656] Dynamic subtest pipe-A-DP-1: SUCCESS (0.713s) [175.990483] Starting dynamic subtest: pipe-B-DP-2 [176.579665] Dynamic subtest pipe-B-DP-2: SUCCESS (0.610s) [176.594625] Starting dynamic subtest: pipe-C-DP-1 [177.241863] Dynamic subtest pipe-C-DP-1: SUCCESS (0.658s) [177.245471] Subtest read-crc: SUCCESS (1.999s) [177.665369] [119/165] (831s left) kms_pipe_crc_basic (read-crc-frame-sequence) [177.985387] Starting subtest: read-crc-frame-sequence [177.988248] Starting dynamic subtest: pipe-A-DP-1 [178.684347] Dynamic subtest pipe-A-DP-1: SUCCESS (0.699s) [178.699606] Starting dynamic subtest: pipe-B-DP-2 [179.294391] Dynamic subtest pipe-B-DP-2: SUCCESS (0.603s) [179.305315] Starting dynamic subtest: pipe-C-DP-1 [179.962103] Dynamic subtest pipe-C-DP-1: SUCCESS (0.661s) [179.966147] Subtest read-crc-frame-sequence: SUCCESS (1.978s) [180.378293] [120/165] (828s left) kms_pm_backlight (basic-brightness) [180.676833] Subtest basic-brightness: SKIP (0.000s) [180.704619] [121/165] (828s left) kms_pm_rpm (basic-pci-d3-state) [182.569053] Starting subtest: basic-pci-d3-state [183.329756] Subtest basic-pci-d3-state: SUCCESS (0.757s) [183.787597] [122/165] (825s left) kms_pm_rpm (basic-rte) [183.867373] Starting subtest: basic-rte [186.401438] Subtest basic-rte: SUCCESS (2.532s) [187.567303] [123/165] (821s left) kms_psr (psr-primary-page-flip) [187.860277] Subtest psr-primary-page-flip: SKIP (0.000s) [187.902349] [124/165] (821s left) kms_psr (psr-cursor-plane-move) [188.189958] Subtest psr-cursor-plane-move: SKIP (0.000s) [188.220722] [125/165] (820s left) kms_psr (psr-sprite-plane-onoff) [188.502951] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [188.537063] [126/165] (820s left) kms_psr (psr-primary-mmap-gtt) [188.846315] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [188.870313] [127/165] (820s left) kms_setmode (basic-clone-single-crtc) [188.943870] Starting subtest: basic-clone-single-crtc [189.118038] Subtest basic-clone-single-crtc: SKIP (0.173s) [189.512520] [128/165] (819s left) i915_pm_rps (basic-api) [189.600154] Starting subtest: basic-api [189.607055] Subtest basic-api: SUCCESS (0.005s) [189.705373] [129/165] (819s left) prime_self_import (basic-llseek-bad) [189.804593] Starting subtest: basic-llseek-bad [189.811219] Subtest basic-llseek-bad: SUCCESS (0.002s) [189.926697] [130/165] (819s left) prime_self_import (basic-llseek-size) [190.012157] Starting subtest: basic-llseek-size [190.019261] Subtest basic-llseek-size: SUCCESS (0.003s) [190.104260] [131/165] (819s left) prime_self_import (basic-with_fd_dup) [190.193242] Starting subtest: basic-with_fd_dup [190.199868] Subtest basic-with_fd_dup: SUCCESS (0.009s) [190.285404] [132/165] (818s left) prime_self_import (basic-with_one_bo) [190.367548] Starting subtest: basic-with_one_bo [190.374477] Subtest basic-with_one_bo: SUCCESS (0.005s) [190.450612] [133/165] (818s left) prime_self_import (basic-with_one_bo_two_files) [190.541318] Starting subtest: basic-with_one_bo_two_files [190.548293] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [190.655836] [134/165] (818s left) prime_self_import (basic-with_two_bos) [190.742230] Starting subtest: basic-with_two_bos [190.748172] Subtest basic-with_two_bos: SUCCESS (0.003s) [190.853235] [135/165] (818s left) prime_vgem (basic-fence-flip) [190.966456] Starting subtest: basic-fence-flip [191.606211] Subtest basic-fence-flip: SUCCESS (0.638s) [191.737452] [136/165] (817s left) prime_vgem (basic-fence-mmap) [191.813868] Starting subtest: basic-fence-mmap [191.840730] Subtest basic-fence-mmap: SUCCESS (0.029s) [191.910229] [137/165] (817s left) prime_vgem (basic-fence-read) [192.017439] Starting subtest: basic-fence-read [192.074166] Subtest basic-fence-read: SUCCESS (0.058s) [192.154451] [138/165] (817s left) prime_vgem (basic-gtt) [192.259301] Starting subtest: basic-gtt [192.282703] Subtest basic-gtt: SUCCESS (0.023s) [192.396693] [139/165] (817s left) prime_vgem (basic-read) [192.487884] Starting subtest: basic-read [192.505609] Subtest basic-read: SUCCESS (0.021s) [192.610168] [140/165] (816s left) prime_vgem (basic-write) [192.725274] Starting subtest: basic-write [192.751869] Subtest basic-write: SUCCESS (0.027s) [192.828819] [141/165] (816s left) vgem_basic (setversion) [192.909412] Starting subtest: setversion [192.916675] Subtest setversion: SUCCESS (0.000s) [192.980077] [142/165] (816s left) vgem_basic (create) [193.062813] Starting subtest: create [193.066525] Subtest create: SUCCESS (0.000s) [193.113631] [143/165] (816s left) vgem_basic (debugfs) [193.193252] Starting subtest: debugfs [193.196520] Subtest debugfs: SUCCESS (0.000s) [193.243081] [144/165] (816s left) vgem_basic (dmabuf-export) [193.324855] Starting subtest: dmabuf-export [193.338844] Subtest dmabuf-export: SUCCESS (0.010s) [193.454904] [145/165] (816s left) vgem_basic (dmabuf-fence) [193.557593] Starting subtest: dmabuf-fence [193.561175] Subtest dmabuf-fence: SUCCESS (0.001s) [193.608503] [146/165] (816s left) vgem_basic (dmabuf-fence-before) [193.691228] Starting subtest: dmabuf-fence-before [193.694840] Subtest dmabuf-fence-before: SUCCESS (0.001s) [193.761117] [147/165] (816s left) vgem_basic (dmabuf-mmap) [193.840431] Starting subtest: dmabuf-mmap [193.850862] Subtest dmabuf-mmap: SUCCESS (0.013s) [193.913770] [148/165] (815s left) vgem_basic (mmap) [193.992578] Starting subtest: mmap [193.999153] Subtest mmap: SUCCESS (0.009s) [194.055369] [149/165] (815s left) vgem_basic (second-client) [194.144271] Starting subtest: second-client [194.173644] Subtest second-client: SUCCESS (0.033s) [194.249928] [150/165] (815s left) vgem_basic (sysfs) [194.339766] Starting subtest: sysfs [194.342797] Subtest sysfs: SUCCESS (0.001s) [194.392578] [151/165] (815s left) core_hotunplug (unbind-rebind) [194.506279] Starting subtest: unbind-rebind [197.884429] Subtest unbind-rebind: SUCCESS (3.378s) [197.908921] [152/165] (812s left) vgem_basic (unload) [197.981912] Starting subtest: unload [227.027350] Subtest unload: SUCCESS (29.044s) [227.175734] [153/165] (782s left) i915_module_load (reload) [227.257533] Starting subtest: reload [230.018841] Subtest reload: SUCCESS (2.766s) [230.040775] [154/165] (780s left) gem_lmem_swapping (basic) [230.125521] Subtest basic: SKIP (0.000s) [230.161467] [155/165] (779s left) gem_lmem_swapping (parallel-random-engines) [230.239382] Subtest parallel-random-engines: SKIP (0.000s) [230.265446] [156/165] (779s left) gem_lmem_swapping (random-engines) [230.337857] Subtest random-engines: SKIP (0.000s) [230.373305] [157/165] (779s left) gem_lmem_swapping (verify-random) [230.459107] Subtest verify-random: SKIP (0.000s) [230.494566] [158/165] (779s left) i915_pm_rpm (module-reload) [232.817835] Starting subtest: module-reload [240.886033] Subtest module-reload: SUCCESS (8.074s) [240.912572] [159/165] (769s left) i915_selftest (live) [241.007419] Starting subtest: live [241.010594] Starting dynamic subtest: sanitycheck [241.663234] Dynamic subtest sanitycheck: SUCCESS (0.655s) [241.675340] Starting dynamic subtest: uncore [242.312229] Dynamic subtest uncore: SUCCESS (0.646s) [242.322282] Starting dynamic subtest: workarounds [243.256098] Dynamic subtest workarounds: SUCCESS (0.942s) [243.267541] Starting dynamic subtest: gt_engines [244.457269] Dynamic subtest gt_engines: SUCCESS (1.197s) [244.466187] Starting dynamic subtest: gt_timelines [255.746140] Dynamic subtest gt_timelines: SUCCESS (11.289s) [255.757216] Starting dynamic subtest: gt_contexts [256.539244] Dynamic subtest gt_contexts: SUCCESS (0.789s) [256.550584] Starting dynamic subtest: gt_lrc [260.206199] Dynamic subtest gt_lrc: SUCCESS (3.664s) [260.215641] Starting dynamic subtest: gt_mocs [260.958251] Dynamic subtest gt_mocs: SUCCESS (0.751s) [260.968212] Starting dynamic subtest: gt_pm [267.541345] Dynamic subtest gt_pm: SUCCESS (6.583s) [267.551014] Starting dynamic subtest: gt_heartbeat [268.308233] Dynamic subtest gt_heartbeat: SUCCESS (0.765s) [268.317737] Starting dynamic subtest: gt_tlb [270.048277] Dynamic subtest gt_tlb: SUCCESS (1.738s) [270.059478] Starting dynamic subtest: requests [278.183036] Dynamic subtest requests: SUCCESS (8.133s) [278.194094] Starting dynamic subtest: migrate [281.666174] Dynamic subtest migrate: SUCCESS (3.481s) [281.676612] Starting dynamic subtest: active [282.354277] Dynamic subtest active: SUCCESS (0.684s) [282.363884] Starting dynamic subtest: objects [284.205199] Dynamic subtest objects: SUCCESS (1.848s) [284.214911] Starting dynamic subtest: mman [288.701082] Dynamic subtest mman: SUCCESS (4.497s) [288.710193] Starting dynamic subtest: dmabuf [289.479122] Dynamic subtest dmabuf: SUCCESS (0.776s) [289.489681] Starting dynamic subtest: vma [290.146064] Dynamic subtest vma: SUCCESS (0.665s) [290.154976] Starting dynamic subtest: coherency [291.767178] Dynamic subtest coherency: SUCCESS (1.619s) [291.779393] Starting dynamic subtest: gtt [299.740101] Dynamic subtest gtt: SUCCESS (7.971s) [299.749791] Starting dynamic subtest: gem [300.565890] Dynamic subtest gem: SUCCESS (0.824s) [300.575480] Starting dynamic subtest: evict [302.920283] Dynamic subtest evict: SUCCESS (2.350s) [302.929856] Starting dynamic subtest: hugepages [310.073175] Dynamic subtest hugepages: SUCCESS (7.151s) [310.085881] Starting dynamic subtest: gem_contexts [326.496135] Dynamic subtest gem_contexts: SUCCESS (16.423s) [326.508229] Starting dynamic subtest: client [327.273115] Dynamic subtest client: SUCCESS (0.775s) [327.282750] Starting dynamic subtest: gem_migrate [327.921177] Dynamic subtest gem_migrate: SUCCESS (0.646s) [327.930969] Starting dynamic subtest: reset [329.413258] Dynamic subtest reset: SUCCESS (1.488s) [329.425177] Starting dynamic subtest: memory_region [330.081086] Dynamic subtest memory_region: SUCCESS (0.668s) [330.090349] Starting dynamic subtest: hangcheck [359.298328] Dynamic subtest hangcheck: SUCCESS (29.212s) [359.308997] Starting dynamic subtest: execlists [372.483271] Dynamic subtest execlists: SUCCESS (13.184s) [372.492530] Starting dynamic subtest: ring_submission [373.166275] Dynamic subtest ring_submission: SUCCESS (0.683s) [373.179771] Starting dynamic subtest: perf [373.968060] Dynamic subtest perf: SUCCESS (0.800s) [373.979312] Starting dynamic subtest: slpc [374.633413] Dynamic subtest slpc: SUCCESS (0.664s) [374.644839] Starting dynamic subtest: guc [375.296087] Dynamic subtest guc: SUCCESS (0.661s) [375.306216] Starting dynamic subtest: guc_multi_lrc [375.963102] Dynamic subtest guc_multi_lrc: SUCCESS (0.665s) [375.975229] Starting dynamic subtest: guc_hang [376.647664] Dynamic subtest guc_hang: SUCCESS (0.683s) [376.660465] Starting dynamic subtest: late_gt_pm [377.339172] Dynamic subtest late_gt_pm: SUCCESS (0.688s) [377.342448] Subtest live: SUCCESS (136.331s) [377.372061] [160/165] (632s left) dmabuf (all-tests) [377.474422] Starting subtest: all-tests [377.477537] Starting dynamic subtest: sanitycheck [377.538932] Dynamic subtest sanitycheck: SUCCESS (0.069s) [377.564201] Starting dynamic subtest: dma_fence [377.724393] Dynamic subtest dma_fence: SUCCESS (0.182s) [377.735029] Starting dynamic subtest: dma_fence_chain [392.322890] Dynamic subtest dma_fence_chain: SUCCESS (14.596s) [392.341640] Starting dynamic subtest: dma_fence_unwrap [392.395979] Dynamic subtest dma_fence_unwrap: SUCCESS (0.070s) [392.416434] Starting dynamic subtest: dma_resv [392.466298] Dynamic subtest dma_resv: SUCCESS (0.065s) [392.470058] Subtest all-tests: SUCCESS (14.996s) [392.508351] [161/165] (617s left) i915_suspend (basic-s2idle-without-i915) [392.597565] Starting subtest: basic-s2idle-without-i915 [411.176095] Subtest basic-s2idle-without-i915: SUCCESS (3.884s) [414.797588] [162/165] (613s left) i915_suspend (basic-s3-without-i915) [414.927610] Starting subtest: basic-s3-without-i915 [433.842119] Subtest basic-s3-without-i915: SUCCESS (3.247s) [437.441743] [163/165] (609s left) gem_exec_suspend (basic-s0) [437.576344] Starting subtest: basic-S0 [437.579446] Starting dynamic subtest: smem [456.118488] Dynamic subtest smem: SUCCESS (2.900s) [456.121589] Subtest basic-S0: SUCCESS (2.901s) [461.300035] [164/165] (606s left) gem_exec_suspend (basic-s3) [461.386413] Starting subtest: basic-S3 [461.389841] Starting dynamic subtest: smem [480.812700] Dynamic subtest smem: SUCCESS (3.531s) [480.816309] Subtest basic-S3: SUCCESS (3.533s) [483.989392] [165/165] (602s left) kms_pipe_crc_basic (suspend-read-crc) [484.308149] Starting subtest: suspend-read-crc [484.311333] Starting dynamic subtest: pipe-A-DP-1 [503.731120] Dynamic subtest pipe-A-DP-1: SUCCESS (3.027s) [503.743633] Starting dynamic subtest: pipe-B-DP-2 [522.669254] Dynamic subtest pipe-B-DP-2: SUCCESS (2.645s) [522.682591] Starting dynamic subtest: pipe-C-DP-1 [542.665164] Dynamic subtest pipe-C-DP-1: SUCCESS (2.978s) [542.668303] Subtest suspend-read-crc: SUCCESS (8.660s) [547.035615] Closing watchdogs Done.