[92.911131] Initializing watchdogs [92.911350] /dev/watchdog0 [92.953422] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [92.968648] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [92.976429] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [92.981861] [001/156] (960s left) gem_workarounds (basic-read) [93.144369] Starting subtest: basic-read [93.168543] Subtest basic-read: SUCCESS (0.024s) [93.319148] [002/156] (960s left) kms_cursor_crc (cursor-random-256x256) [93.537078] Starting subtest: cursor-random-256x256 [93.639103] Starting dynamic subtest: pipe-A-HDMI-A-1 [97.931065] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.284s) [98.037593] Starting dynamic subtest: pipe-C-HDMI-A-1 [101.884583] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.883s) [101.888731] Subtest cursor-random-256x256: SUCCESS (8.346s) [102.241919] [003/156] (951s left) kms_color (ctm-0-50) [102.437646] Starting subtest: ctm-0-50 [102.439258] Starting dynamic subtest: pipe-A-HDMI-A-1 [104.007150] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.566s) [104.027750] Starting dynamic subtest: pipe-A-HDMI-A-2 [105.343124] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.331s) [105.368196] Starting dynamic subtest: pipe-B-HDMI-A-1 [106.605795] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.261s) [106.650539] Starting dynamic subtest: pipe-B-HDMI-A-2 [107.861277] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.254s) [107.884274] Starting dynamic subtest: pipe-C-HDMI-A-1 [109.155134] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.289s) [109.178329] Starting dynamic subtest: pipe-C-HDMI-A-2 [110.455273] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.296s) [110.460758] Subtest ctm-0-50: SUCCESS (8.016s) [110.747332] [004/156] (942s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [110.947074] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [111.040127] [005/156] (942s left) kms_psr (psr-cursor-render) [111.233927] Subtest psr-cursor-render: SKIP (0.000s) [111.339026] [006/156] (942s left) template (a) [111.442285] Starting subtest: A [111.445069] Subtest A: SUCCESS (0.000s) [111.608937] [007/156] (942s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt) [111.821692] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt [111.828333] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [111.966022] [008/156] (942s left) i915_suspend (basic-s2idle-without-i915) [112.072294] Starting subtest: basic-s2idle-without-i915 [132.322034] Subtest basic-s2idle-without-i915: SUCCESS (5.240s) [143.582823] [009/156] (921s left) prime_busy (after) [143.724374] Starting subtest: after [143.742059] Starting dynamic subtest: rcs0 [143.766004] Dynamic subtest rcs0: SUCCESS (0.025s) [143.800506] Starting dynamic subtest: bcs0 [143.802476] Dynamic subtest bcs0: SUCCESS (0.018s) [143.829476] Starting dynamic subtest: vcs0 [143.832107] Dynamic subtest vcs0: SUCCESS (0.020s) [143.855044] Starting dynamic subtest: vecs0 [143.857674] Dynamic subtest vecs0: SUCCESS (0.012s) [143.935637] Subtest after: SUCCESS (0.199s) [144.082939] [010/156] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [144.296941] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [147.232684] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.853s) [147.559056] [011/156] (917s left) gem_exec_fence (parallel) [147.829451] Starting subtest: parallel [147.831171] Starting dynamic subtest: rcs0 [150.029909] Dynamic subtest rcs0: SUCCESS (2.156s) [150.057049] Starting dynamic subtest: bcs0 [152.216154] Dynamic subtest bcs0: SUCCESS (2.151s) [152.246492] Starting dynamic subtest: vcs0 [154.393968] Dynamic subtest vcs0: SUCCESS (2.154s) [154.423821] Starting dynamic subtest: vecs0 [156.567226] Dynamic subtest vecs0: SUCCESS (2.151s) [156.569905] Subtest parallel: SUCCESS (8.617s) [157.333943] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true [157.339523] [012/156] (908s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-move) [157.554966] Starting subtest: fbchdr-1p-primscrn-cur-indfb-move [157.559684] Subtest fbchdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [157.708418] [013/156] (907s left) kms_psr (fbc-psr-sprite-mmap-cpu) [157.899123] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s) [158.018020] [014/156] (907s left) i915_query (query-topology-unsupported) [158.127013] Starting subtest: query-topology-unsupported [158.132586] Subtest query-topology-unsupported: SKIP (0.000s) [158.305165] [015/156] (907s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [158.522309] Starting subtest: plane-scaler-with-clipping-clamping-rotation [158.527868] Starting dynamic subtest: pipe-A [162.791820] Dynamic subtest pipe-A: SKIP (4.244s) [162.819763] Starting dynamic subtest: pipe-B [167.214465] Dynamic subtest pipe-B: SKIP (4.409s) [167.267081] Starting dynamic subtest: pipe-C [172.029508] Dynamic subtest pipe-C: SKIP (4.803s) [172.035528] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (13.463s) [172.581372] [016/156] (893s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-pwrite) [172.861488] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-pwrite [172.865831] Subtest hdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.001s) [173.019009] [017/156] (893s left) kms_content_protection (dp-mst-type-0-suspend-resume) [173.245391] Starting subtest: dp-mst-type-0-suspend-resume [173.254038] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s) [173.420661] [018/156] (892s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [173.661600] Starting subtest: fbc-2p-pri-indfb-multidraw [190.527579] Subtest fbc-2p-pri-indfb-multidraw: SUCCESS (16.855s) [190.765522] [019/156] (875s left) gen9_exec_parse (valid-registers) [190.901412] Starting subtest: valid-registers [191.072318] Subtest valid-registers: SUCCESS (0.172s) [191.347351] [020/156] (875s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [191.565266] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt [191.571191] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [191.729379] [021/156] (874s left) kms_cursor_crc (cursor-offscreen-64x21) [191.947673] Starting subtest: cursor-offscreen-64x21 [192.020187] Starting dynamic subtest: pipe-A-HDMI-A-1 [194.867317] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.844s) [194.986674] Starting dynamic subtest: pipe-C-HDMI-A-1 [197.527189] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.582s) [197.530111] Subtest cursor-offscreen-64x21: SUCCESS (5.581s) [197.939987] [022/156] (868s left) syncobj_timeline (reset-unsignaled) [198.057737] Starting subtest: reset-unsignaled [198.061455] Subtest reset-unsignaled: SUCCESS (0.000s) [198.227566] [023/156] (868s left) kms_flip (busy-flip) [198.415866] Starting subtest: busy-flip [198.428490] Starting dynamic subtest: A-HDMI-A1 [199.649606] Dynamic subtest A-HDMI-A1: SUCCESS (1.223s) [199.678454] Starting dynamic subtest: B-HDMI-A1 [200.601408] Dynamic subtest B-HDMI-A1: SUCCESS (0.946s) [200.632333] Starting dynamic subtest: C-HDMI-A1 [201.501905] Dynamic subtest C-HDMI-A1: SUCCESS (0.893s) [201.531692] Starting dynamic subtest: A-HDMI-A2 [202.426034] Dynamic subtest A-HDMI-A2: SUCCESS (0.920s) [202.454787] Starting dynamic subtest: B-HDMI-A2 [203.332299] Dynamic subtest B-HDMI-A2: SUCCESS (0.900s) [203.362345] Starting dynamic subtest: C-HDMI-A2 [204.281038] Dynamic subtest C-HDMI-A2: SUCCESS (0.939s) [204.284427] Subtest busy-flip: SUCCESS (5.863s) [204.830815] [024/156] (861s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [204.943032] Starting subtest: etime-multi-wait-for-submit-unsubmitted [205.047883] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s) [205.227368] [025/156] (861s left) gem_exec_schedule (preempt-queue-contexts) [205.368915] Starting subtest: preempt-queue-contexts [205.371380] Starting dynamic subtest: rcs0 [206.175883] Dynamic subtest rcs0: SUCCESS (0.788s) [206.204332] Starting dynamic subtest: bcs0 [206.941043] Dynamic subtest bcs0: SUCCESS (0.776s) [206.971964] Starting dynamic subtest: vcs0 [207.702762] Dynamic subtest vcs0: SUCCESS (0.752s) [207.754918] Starting dynamic subtest: vecs0 [208.445329] Dynamic subtest vecs0: SUCCESS (0.737s) [208.454176] Subtest preempt-queue-contexts: SUCCESS (3.080s) [208.868522] [026/156] (858s left) gem_exec_balancer (bonded-true-hang) [209.118043] Starting subtest: bonded-true-hang [213.374999] Subtest bonded-true-hang: SUCCESS (4.258s) [213.564727] [027/156] (853s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [213.684038] Starting subtest: y-tiled-to-vebox-x-tiled [213.687189] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [213.953734] [028/156] (853s left) gem_exec_balancer (sequential) [214.083922] Starting subtest: sequential [218.491271] Subtest sequential: SUCCESS (4.402s) [218.771992] [029/156] (848s left) kms_feature_discovery (psr1) [218.963654] Starting subtest: psr1 [218.967174] Subtest psr1: SKIP (0.000s) [219.118291] [030/156] (848s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [219.319703] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt [219.323994] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [219.472652] [031/156] (848s left) kms_frontbuffer_tracking (psr-suspend) [219.683607] Starting subtest: psr-suspend [219.688360] Subtest psr-suspend: SKIP (0.000s) [219.867152] [032/156] (847s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [220.072419] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [220.076935] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [220.221867] [033/156] (847s left) kms_plane_alpha_blend (alpha-transparent-fb) [220.404179] Starting subtest: alpha-transparent-fb [220.560332] Starting dynamic subtest: pipe-A-HDMI-A-1 [221.466701] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.436s) [221.495424] Starting dynamic subtest: pipe-C-HDMI-A-1 [222.052713] Dynamic subtest pipe-C-HDMI-A-1: FAIL (0.494s) [222.054308] Subtest alpha-transparent-fb: FAIL (1.098s) [222.164044] [034/156] (845s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc) [222.371326] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc [222.374777] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [222.519230] [035/156] (845s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping) [222.719297] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping [222.724812] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s) [222.869594] [036/156] (845s left) gem_mmap_gtt (basic-small-bo) [222.978713] Starting subtest: basic-small-bo [224.058723] Subtest basic-small-bo: SUCCESS (1.081s) [224.259480] [037/156] (843s left) kms_flip (2x-flip-vs-rmfb) [224.615718] Starting subtest: 2x-flip-vs-rmfb [224.618310] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [235.559044] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.941s) [235.590067] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [246.381613] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.817s) [246.416698] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [257.179110] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.791s) [257.181012] Subtest 2x-flip-vs-rmfb: SUCCESS (32.577s) [257.861621] [038/156] (810s left) kms_universal_plane (universal-plane-sanity) [258.061818] Starting subtest: universal-plane-sanity [258.072958] Starting dynamic subtest: pipe-A-HDMI-A-1 [258.877105] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.808s) [258.920715] Starting dynamic subtest: pipe-B-HDMI-A-2 [259.411398] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.527s) [259.445614] Starting dynamic subtest: pipe-C-HDMI-A-1 [259.967327] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.546s) [259.969523] Subtest universal-plane-sanity: SUCCESS (1.906s) [260.324713] [039/156] (808s left) gem_exec_schedule (promotion) [260.495790] Starting subtest: promotion [260.500309] Starting dynamic subtest: rcs0 [260.622421] Dynamic subtest rcs0: SUCCESS (0.121s) [260.665600] Starting dynamic subtest: bcs0 [260.776784] Dynamic subtest bcs0: SUCCESS (0.145s) [260.818674] Starting dynamic subtest: vcs0 [260.905319] Dynamic subtest vcs0: SUCCESS (0.125s) [260.947527] Starting dynamic subtest: vecs0 [261.036674] Dynamic subtest vecs0: SUCCESS (0.129s) [261.038342] Subtest promotion: SUCCESS (0.538s) [261.477585] [040/156] (806s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [261.686929] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-gtt [261.690705] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [261.848043] [041/156] (806s left) kms_chamelium_color (degamma) [262.059283] Subtest degamma: SKIP (0.000s) [262.173703] [042/156] (806s left) syncobj_wait (multi-wait-for-submit-signaled) [262.291691] Starting subtest: multi-wait-for-submit-signaled [262.295834] Subtest multi-wait-for-submit-signaled: SUCCESS (0.002s) [262.451073] [043/156] (806s left) gem_sync (basic-all) [262.587994] Starting subtest: basic-all [264.998933] Subtest basic-all: SUCCESS (2.414s) [265.265628] [044/156] (803s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [265.477629] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu [265.482435] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [265.642374] [045/156] (803s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-plflip-blt) [265.864912] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-plflip-blt [265.870311] Subtest fbcpsrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [266.028313] [046/156] (803s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted) [266.144165] Starting subtest: etime-multi-wait-all-available-unsubmitted [266.247875] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.104s) [266.409827] [047/156] (802s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [266.603150] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [266.607088] Starting dynamic subtest: pipe-A-HDMI-A-1 [266.637439] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [266.691553] Starting dynamic subtest: pipe-A-HDMI-A-2 [266.733891] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s) [266.788617] Starting dynamic subtest: pipe-B-HDMI-A-1 [266.829318] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [266.855826] Starting dynamic subtest: pipe-B-HDMI-A-2 [266.879272] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [266.904672] Starting dynamic subtest: pipe-C-HDMI-A-1 [266.921144] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [266.946062] Starting dynamic subtest: pipe-C-HDMI-A-2 [266.962662] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s) [266.965705] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.051s) [267.751491] [048/156] (801s left) gem_mmap_gtt (close-race) [267.864394] Starting subtest: close-race [287.917975] Subtest close-race: SUCCESS (20.053s) [288.092487] [049/156] (781s left) syncobj_wait (wait-delayed-signal) [288.200888] Starting subtest: wait-delayed-signal [288.300873] Subtest wait-delayed-signal: SUCCESS (0.106s) [288.469823] [050/156] (781s left) perf (gen12-group-exclusive-stream-sample-oa) [288.736531] Starting subtest: gen12-group-exclusive-stream-sample-oa [288.740112] Subtest gen12-group-exclusive-stream-sample-oa: SKIP (0.000s) [288.860432] [051/156] (780s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [289.065529] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [292.601001] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.538s) [292.895924] [052/156] (776s left) kms_big_fb (x-tiled-64bpp-rotate-180) [293.113412] Starting subtest: x-tiled-64bpp-rotate-180 [298.102361] Subtest x-tiled-64bpp-rotate-180: SUCCESS (4.993s) [298.652792] [053/156] (771s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [298.833449] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [298.836380] Starting dynamic subtest: pipe-A-HDMI-A-1 [298.924334] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s) [298.980868] Starting dynamic subtest: pipe-A-HDMI-A-2 [299.089650] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.013s) [299.116455] Starting dynamic subtest: pipe-B-HDMI-A-1 [299.181448] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.013s) [299.206563] Starting dynamic subtest: pipe-B-HDMI-A-2 [299.273906] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.012s) [299.298858] Starting dynamic subtest: pipe-C-HDMI-A-1 [299.366473] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.012s) [299.391691] Starting dynamic subtest: pipe-C-HDMI-A-2 [299.500820] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.011s) [299.506464] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.108s) [300.036958] [054/156] (769s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [300.224640] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [300.228552] Starting dynamic subtest: pipe-A-HDMI-A-1 [300.249058] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s) [300.309412] Starting dynamic subtest: pipe-A-HDMI-A-2 [300.354996] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s) [300.388395] Starting dynamic subtest: pipe-B-HDMI-A-1 [300.404115] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s) [300.428962] Starting dynamic subtest: pipe-B-HDMI-A-2 [300.447359] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.003s) [300.475328] Starting dynamic subtest: pipe-C-HDMI-A-1 [300.492001] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [300.516726] Starting dynamic subtest: pipe-C-HDMI-A-2 [300.531759] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s) [300.534884] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.045s) [301.325056] [055/156] (768s left) kms_cursor_legacy (cursor-vs-flip-toggle) [301.524335] Starting subtest: cursor-vs-flip-toggle [347.470420] Subtest cursor-vs-flip-toggle: SUCCESS (45.928s) [347.842342] [056/156] (722s left) gem_ctx_persistence (engines-queued) [347.961582] Starting subtest: engines-queued [347.963254] Starting dynamic subtest: rcs0 [348.014432] Dynamic subtest rcs0: SUCCESS (0.049s) [348.050411] Starting dynamic subtest: bcs0 [348.146801] Dynamic subtest bcs0: SUCCESS (0.130s) [348.177276] Starting dynamic subtest: vcs0 [348.188504] Dynamic subtest vcs0: SUCCESS (0.036s) [348.218658] Starting dynamic subtest: vecs0 [348.246470] Dynamic subtest vecs0: SUCCESS (0.054s) [348.248563] Subtest engines-queued: SUCCESS (0.287s) [348.430590] [057/156] (721s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt) [348.629464] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt [351.041552] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (2.414s) [351.411771] [058/156] (718s left) gem_cs_tlb (engines) [351.528648] Starting subtest: engines [351.531352] Starting dynamic subtest: rcs0 [353.690367] Dynamic subtest rcs0: SUCCESS (2.155s) [353.722718] Starting dynamic subtest: bcs0 [355.851955] Dynamic subtest bcs0: SUCCESS (2.157s) [355.886025] Starting dynamic subtest: vcs0 [358.011893] Dynamic subtest vcs0: SUCCESS (2.155s) [358.043496] Starting dynamic subtest: vecs0 [360.168870] Dynamic subtest vecs0: SUCCESS (2.156s) [360.172300] Subtest engines: SUCCESS (8.637s) [360.315939] [059/156] (710s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [360.890182] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [361.261853] [060/156] (709s left) gem_eio (context-create) [361.433628] Starting subtest: context-create [361.488019] Subtest context-create: SUCCESS (0.057s) [361.762406] [061/156] (708s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [361.974345] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [361.983598] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.003s) [362.174362] [062/156] (708s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-blt) [362.379548] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-blt [362.383664] Subtest psrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [362.548042] [063/156] (708s left) gem_mmap (basic-small-bo) [362.656379] Starting subtest: basic-small-bo [363.044525] Subtest basic-small-bo: SUCCESS (0.388s) [363.216631] [064/156] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [363.600799] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [363.605588] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [363.763170] [065/156] (707s left) perf_pmu (gt-awake) [363.893529] Starting subtest: gt-awake [366.451794] Subtest gt-awake: SUCCESS (2.564s) [366.613966] [066/156] (704s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt) [366.809791] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt [366.813531] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [366.964011] [067/156] (704s left) kms_flip (2x-plain-flip-interruptible) [367.174296] Starting subtest: 2x-plain-flip-interruptible [367.180616] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [368.731770] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.549s) [368.767670] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [370.160846] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.423s) [370.196026] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [371.616289] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.446s) [371.620109] Subtest 2x-plain-flip-interruptible: SUCCESS (4.443s) [372.368802] [068/156] (699s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [372.573902] Starting subtest: cursorB-vs-flipB-legacy [383.903803] Subtest cursorB-vs-flipB-legacy: SUCCESS (11.333s) [384.335433] [069/156] (687s left) gem_ctx_param (get-priority-new-ctx) [384.447630] Starting subtest: get-priority-new-ctx [384.449527] Subtest get-priority-new-ctx: SUCCESS (0.000s) [384.632372] [070/156] (686s left) kms_setmode (basic-clone-single-crtc) [384.738180] Starting subtest: basic-clone-single-crtc [385.230290] Subtest basic-clone-single-crtc: SKIP (0.490s) [385.567257] [071/156] (686s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [385.782811] Starting subtest: extended-modeset-hang-oldfb-with-reset [385.784911] Starting dynamic subtest: pipe-A [397.191304] Dynamic subtest pipe-A: SUCCESS (11.403s) [397.228429] Starting dynamic subtest: pipe-C [408.425779] Dynamic subtest pipe-C: SUCCESS (11.223s) [408.428635] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (22.649s) [408.848623] [072/156] (662s left) gem_exec_reloc (basic-cpu-read) [408.974607] Starting subtest: basic-cpu-read [408.992607] Subtest basic-cpu-read: SUCCESS (0.016s) [409.246736] [073/156] (662s left) kms_frontbuffer_tracking (fbchdr-suspend) [409.471544] Starting subtest: fbchdr-suspend [409.476927] Subtest fbchdr-suspend: SKIP (0.000s) [409.637109] [074/156] (662s left) gem_exec_capture (userptr) [409.764673] Starting subtest: userptr [411.064135] Subtest userptr: SUCCESS (1.301s) [411.223518] [075/156] (660s left) gem_exec_whisper (basic-fds-priority) [411.360486] Starting subtest: basic-fds-priority [421.230529] Subtest basic-fds-priority: SUCCESS (9.872s) [421.518573] [076/156] (650s left) syncobj_timeline (single-wait-for-submit-available-submitted) [421.644374] Starting subtest: single-wait-for-submit-available-submitted [421.646134] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.002s) [421.829892] [077/156] (650s left) gen7_exec_parse (cmd-crossing-page) [421.951438] Subtest cmd-crossing-page: SKIP (0.000s) [422.078892] [078/156] (650s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary) [422.278527] Starting subtest: psrhdr-indfb-scaledprimary [422.284199] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s) [422.452198] [079/156] (650s left) kms_async_flips (async-flip-with-page-flip-events-linear) [422.648830] Starting subtest: async-flip-with-page-flip-events-linear [423.276756] Subtest async-flip-with-page-flip-events-linear: SKIP (0.626s) [423.631265] [080/156] (649s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [423.836483] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [423.960035] [081/156] (648s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [424.152800] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [424.157596] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [424.947377] [082/156] (647s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [425.135475] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [425.139741] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.000s) [425.283231] [083/156] (647s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw) [425.501456] Starting subtest: fbchdr-2p-pri-indfb-multidraw [425.505658] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s) [425.662632] [084/156] (647s left) kms_lease (setcrtc-implicit-plane) [425.862640] Starting subtest: setcrtc-implicit-plane [425.864504] Starting dynamic subtest: pipe-A-HDMI-A-1 [426.592603] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.730s) [426.672396] Starting dynamic subtest: pipe-A-HDMI-A-2 [427.100710] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.492s) [427.164523] Starting dynamic subtest: pipe-B-HDMI-A-1 [427.561150] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.458s) [427.606144] Starting dynamic subtest: pipe-B-HDMI-A-2 [428.032315] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.460s) [428.098675] Starting dynamic subtest: pipe-C-HDMI-A-1 [428.512669] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.473s) [428.566981] Starting dynamic subtest: pipe-C-HDMI-A-2 [429.072831] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.541s) [429.077933] Subtest setcrtc-implicit-plane: SUCCESS (3.209s) [429.459153] [085/156] (643s left) gem_softpin (allocator-nopin-reserve) [429.582433] Starting subtest: allocator-nopin-reserve [429.820586] Subtest allocator-nopin-reserve: SUCCESS (0.232s) [429.994589] [086/156] (643s left) kms_psr (pr-primary-mmap-gtt) [430.184477] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [430.316677] [087/156] (643s left) kms_plane (pixel-format-linear-modifier-source-clamping) [430.502219] Starting subtest: pixel-format-linear-modifier-source-clamping [430.724457] Starting dynamic subtest: pipe-A-plane-0 [431.285466] Dynamic subtest pipe-A-plane-0: SUCCESS (0.563s) [431.318831] Starting dynamic subtest: pipe-A-plane-1 [431.854878] Dynamic subtest pipe-A-plane-1: SUCCESS (0.563s) [431.882994] Starting dynamic subtest: pipe-A-plane-2 [432.403739] Dynamic subtest pipe-A-plane-2: SUCCESS (0.546s) [432.436417] Starting dynamic subtest: pipe-A-plane-3 [432.969871] Dynamic subtest pipe-A-plane-3: SUCCESS (0.561s) [433.394469] Starting dynamic subtest: pipe-B-plane-0 [433.918074] Dynamic subtest pipe-B-plane-0: SUCCESS (0.549s) [433.947484] Starting dynamic subtest: pipe-B-plane-1 [434.485200] Dynamic subtest pipe-B-plane-1: SUCCESS (0.563s) [434.515019] Starting dynamic subtest: pipe-B-plane-2 [435.034892] Dynamic subtest pipe-B-plane-2: SUCCESS (0.546s) [435.064077] Starting dynamic subtest: pipe-B-plane-3 [435.584729] Dynamic subtest pipe-B-plane-3: SUCCESS (0.546s) [435.810668] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (5.303s) [436.203094] [088/156] (637s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [436.424358] Starting subtest: yf-tiled-16bpp-rotate-180 [440.263833] Subtest yf-tiled-16bpp-rotate-180: SUCCESS (3.838s) [440.653078] [089/156] (633s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [440.872345] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [440.877673] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [441.036581] [090/156] (632s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [441.238646] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [441.244532] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [441.388046] [091/156] (632s left) gem_softpin (noreloc) [441.515938] Starting subtest: noreloc [446.927206] Subtest noreloc: SUCCESS (5.407s) [447.108947] [092/156] (626s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [447.324317] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [447.330380] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [447.490188] [093/156] (626s left) gem_userptr_blits (dmabuf-unsync) [447.616429] Subtest dmabuf-unsync: SKIP (0.000s) [447.824910] [094/156] (626s left) gem_userptr_blits (stress-purge) [447.969387] Starting subtest: stress-purge [453.396008] Subtest stress-purge: SUCCESS (5.434s) [453.610995] [095/156] (620s left) vgem_basic (bad-fence) [453.892485] Starting subtest: bad-fence [453.895412] Subtest bad-fence: SUCCESS (0.000s) [454.024181] [096/156] (620s left) gem_render_copy (linear-to-vebox-yf-tiled) [454.154345] Starting subtest: linear-to-vebox-yf-tiled [454.159056] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [454.422215] [097/156] (620s left) gem_exec_reloc (basic-concurrent16) [454.548398] Starting subtest: basic-concurrent16 [459.996308] Subtest basic-concurrent16: SUCCESS (5.448s) [460.259370] [098/156] (614s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-plflip-blt) [460.486507] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-plflip-blt [460.490739] Subtest fbcpsrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [460.641304] [099/156] (614s left) kms_properties (plane-properties-atomic) [460.835735] Starting subtest: plane-properties-atomic [460.848531] Starting dynamic subtest: pipe-A-HDMI-A-1 [461.636650] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.796s) [461.711903] Starting dynamic subtest: pipe-B-HDMI-A-2 [462.204790] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.558s) [462.257815] Starting dynamic subtest: pipe-C-HDMI-A-1 [462.822927] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.611s) [462.826349] Subtest plane-properties-atomic: SUCCESS (1.987s) [463.182733] [100/156] (611s left) gem_mmap_gtt (basic-write-gtt) [463.301803] Starting subtest: basic-write-gtt [464.027445] Subtest basic-write-gtt: SUCCESS (0.731s) [464.186008] [101/156] (610s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [464.370383] Starting subtest: plane-use-after-nonblocking-unbind [464.373809] Starting dynamic subtest: pipe-A-HDMI-A-1 [464.826730] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.456s) [465.121764] Starting dynamic subtest: pipe-A-HDMI-A-2 [465.750847] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.662s) [466.072680] Starting dynamic subtest: pipe-B-HDMI-A-1 [466.504851] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.499s) [466.813561] Starting dynamic subtest: pipe-B-HDMI-A-2 [467.277432] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.529s) [467.510615] Subtest plane-use-after-nonblocking-unbind: SUCCESS (3.142s) [467.970657] [102/156] (607s left) kms_big_fb (4-tiled-64bpp-rotate-0) [468.202097] Starting subtest: 4-tiled-64bpp-rotate-0 [468.206197] Subtest 4-tiled-64bpp-rotate-0: SKIP (0.000s) [468.375215] [103/156] (606s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc) [468.600567] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc [468.605510] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s) [468.776224] [104/156] (606s left) core_getstats (basic) [468.886660] Starting subtest: basic [468.889148] Subtest basic: SUCCESS (0.000s) [469.061268] [105/156] (606s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-pwrite) [469.283850] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-pwrite [469.289548] Subtest hdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [469.452031] [106/156] (606s left) syncobj_timeline (multi-wait-all-available-signaled) [469.590531] Starting subtest: multi-wait-all-available-signaled [469.592377] Subtest multi-wait-all-available-signaled: SUCCESS (0.002s) [469.760125] [107/156] (605s left) gem_mmap_wc (write-wc-read-gtt) [469.871499] Starting subtest: write-wc-read-gtt [470.338033] Subtest write-wc-read-gtt: SUCCESS (0.468s) [470.492311] [108/156] (605s left) kms_pm_dc (dc5-dpms-negative) [471.705452] Starting subtest: dc5-dpms-negative [475.943028] Subtest dc5-dpms-negative: SUCCESS (4.238s) [476.110173] [109/156] (599s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [476.309549] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [476.314305] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [476.476159] [110/156] (599s left) drm_read (fault-buffer) [476.957420] Starting subtest: fault-buffer [476.967477] Subtest fault-buffer: SUCCESS (0.003s) [477.275490] [111/156] (598s left) device_reset (unbind-cold-reset-rebind) [477.423201] Starting subtest: unbind-cold-reset-rebind [477.428288] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [477.578445] [112/156] (598s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-render) [477.795479] Starting subtest: fbcpsrhdr-rgb565-draw-render [477.799820] Subtest fbcpsrhdr-rgb565-draw-render: SKIP (0.000s) [477.958867] [113/156] (598s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [478.151273] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [478.157096] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [478.309569] [114/156] (598s left) kms_joiner (invalid-modeset-ultra-joiner) [478.506703] Starting subtest: invalid-modeset-ultra-joiner [478.510895] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [478.703697] [115/156] (597s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [478.903551] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [481.684735] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.786s) [481.992830] [116/156] (594s left) syncobj_wait (invalid-reset-illegal-handle) [482.108557] Starting subtest: invalid-reset-illegal-handle [482.111660] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [482.257769] [117/156] (594s left) gem_userptr_blits (sync-unmap-after-close) [482.399416] Starting subtest: sync-unmap-after-close [482.438308] Subtest sync-unmap-after-close: SUCCESS (0.040s) [482.641524] [118/156] (594s left) gem_lmem_swapping (heavy-multi) [482.766649] Subtest heavy-multi: SKIP (0.000s) [482.884472] [119/156] (594s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-fullscreen) [483.093688] Starting subtest: hdr-2p-primscrn-spr-indfb-fullscreen [483.098592] Subtest hdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [483.260206] [120/156] (593s left) kms_getfb (getfb-reject-nv12) [483.456982] Starting subtest: getfb-reject-nv12 [483.459853] Subtest getfb-reject-nv12: SUCCESS (0.003s) [483.624616] [121/156] (593s left) kms_pm_rpm (modeset-non-lpsp) [485.564300] Starting subtest: modeset-non-lpsp [485.960192] Subtest modeset-non-lpsp: SUCCESS (0.382s) [486.370097] [122/156] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt) [486.601494] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt [486.607320] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [486.760206] [123/156] (590s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [486.974868] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu [486.979170] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [487.140755] [124/156] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [487.349262] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [487.353666] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [487.511130] [125/156] (590s left) gem_userptr_blits (readonly-unsync) [487.638420] Subtest readonly-unsync: SKIP (0.000s) [487.845501] [126/156] (589s left) gem_exec_parallel (fds) [487.975551] Starting subtest: fds [487.977347] Starting dynamic subtest: rcs0 [493.427189] Dynamic subtest rcs0: SUCCESS (5.448s) [493.463565] Starting dynamic subtest: bcs0 [499.161598] Dynamic subtest bcs0: SUCCESS (5.729s) [499.201189] Starting dynamic subtest: vcs0 [504.666924] Dynamic subtest vcs0: SUCCESS (5.501s) [504.705381] Starting dynamic subtest: vecs0 [510.558773] Dynamic subtest vecs0: SUCCESS (5.886s) [510.560835] Subtest fds: SUCCESS (22.580s) [510.853723] [127/156] (566s left) kms_big_fb (y-tiled-64bpp-rotate-90) [511.061328] Starting subtest: y-tiled-64bpp-rotate-90 [511.372453] Subtest y-tiled-64bpp-rotate-90: SKIP (0.305s) [511.710525] [128/156] (566s left) kms_cursor_edge_walk (64x64-left-edge) [511.911542] Starting subtest: 64x64-left-edge [511.915102] Starting dynamic subtest: pipe-A-HDMI-A-1 [515.857903] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.942s) [515.912025] Starting dynamic subtest: pipe-C-HDMI-A-1 [519.355113] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.485s) [519.359777] Subtest 64x64-left-edge: SUCCESS (7.442s) [519.687115] [129/156] (558s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [519.910474] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [519.915157] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [520.073543] [130/156] (558s left) gem_barrier_race (remote-request) [520.226396] Starting subtest: remote-request [520.228027] Starting dynamic subtest: rcs0 [525.310759] Dynamic subtest rcs0: SUCCESS (5.080s) [525.316551] Subtest remote-request: SUCCESS (5.087s) [525.479330] [131/156] (552s left) kms_properties (colorop-properties-legacy) [525.668438] Starting subtest: colorop-properties-legacy [525.672768] Starting dynamic subtest: pipe-A-HDMI-A-1 [526.134426] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.461s) [526.184622] Starting dynamic subtest: pipe-A-HDMI-A-2 [526.486199] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.341s) [526.538494] Starting dynamic subtest: pipe-B-HDMI-A-1 [526.814934] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.323s) [526.878511] Starting dynamic subtest: pipe-B-HDMI-A-2 [527.192544] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.364s) [527.246275] Starting dynamic subtest: pipe-C-HDMI-A-1 [527.551372] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.359s) [527.594304] Starting dynamic subtest: pipe-C-HDMI-A-2 [527.893351] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.332s) [527.896544] Subtest colorop-properties-legacy: SUCCESS (2.224s) [528.288402] [132/156] (550s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt) [528.509948] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt [528.515297] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [528.670151] [133/156] (549s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [528.879410] Subtest invalidate-primary-flip-overlay: SKIP (0.000s) [529.083017] [134/156] (549s left) gem_exec_reloc (basic-cpu) [529.239428] Starting subtest: basic-cpu [529.271730] Subtest basic-cpu: SUCCESS (0.037s) [529.688353] [135/156] (549s left) gem_mmap_offset (close-race) [529.845416] Starting subtest: close-race [555.701301] Subtest close-race: SUCCESS (25.858s) [555.877007] [136/156] (523s left) kms_psr (fbc-pr-sprite-render) [556.063730] Subtest fbc-pr-sprite-render: SKIP (0.000s) [556.185216] [137/156] (522s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [556.377476] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [556.379733] Starting dynamic subtest: pipe-A-HDMI-A-1 [556.405613] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s) [556.469976] Starting dynamic subtest: pipe-A-HDMI-A-2 [556.523007] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s) [556.564473] Starting dynamic subtest: pipe-B-HDMI-A-1 [556.589593] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s) [556.620315] Starting dynamic subtest: pipe-B-HDMI-A-2 [556.635938] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.003s) [556.665377] Starting dynamic subtest: pipe-C-HDMI-A-1 [556.680358] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.004s) [556.710302] Starting dynamic subtest: pipe-C-HDMI-A-2 [556.725383] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.005s) [556.728482] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.063s) [557.511513] [138/156] (521s left) kms_vblank (ts-continuation-idle) [557.707314] Starting subtest: ts-continuation-idle [557.708897] Starting dynamic subtest: pipe-A-HDMI-A-1 [558.358294] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.650s) [558.395497] Starting dynamic subtest: pipe-A-HDMI-A-2 [558.826584] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.461s) [558.901593] Starting dynamic subtest: pipe-C-HDMI-A-1 [559.237618] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.399s) [559.292251] Starting dynamic subtest: pipe-C-HDMI-A-2 [559.653630] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.409s) [559.655358] Subtest ts-continuation-idle: SUCCESS (1.955s) [560.037078] [139/156] (519s left) gem_ctx_persistence (legacy-engines-persistence) [560.170279] Starting subtest: legacy-engines-persistence [560.171979] Starting dynamic subtest: render [560.913773] Dynamic subtest render: SUCCESS (0.746s) [560.952733] Starting dynamic subtest: bsd [561.685992] Dynamic subtest bsd: SUCCESS (0.761s) [561.723113] Starting dynamic subtest: blt [562.451363] Dynamic subtest blt: SUCCESS (0.762s) [562.484930] Starting dynamic subtest: vebox [563.218011] Dynamic subtest vebox: SUCCESS (0.760s) [563.224445] Subtest legacy-engines-persistence: SUCCESS (3.057s) [563.394484] [140/156] (516s left) i915_drm_fdinfo (virtual-busy-idle-all) [563.531899] Starting subtest: virtual-busy-idle-all [563.535919] Subtest virtual-busy-idle-all: SUCCESS (0.003s) [563.696033] [141/156] (515s left) kms_flip (plain-flip-ts-check) [563.880392] Starting subtest: plain-flip-ts-check [563.883414] Starting dynamic subtest: A-HDMI-A1 [569.864383] Dynamic subtest A-HDMI-A1: SUCCESS (5.982s) [569.899727] Starting dynamic subtest: B-HDMI-A1 [575.583692] Dynamic subtest B-HDMI-A1: SUCCESS (5.713s) [575.618231] Starting dynamic subtest: C-HDMI-A1 [581.281135] Dynamic subtest C-HDMI-A1: SUCCESS (5.692s) [581.317549] Starting dynamic subtest: A-HDMI-A2 [587.001633] Dynamic subtest A-HDMI-A2: SUCCESS (5.712s) [587.035938] Starting dynamic subtest: B-HDMI-A2 [592.731976] Dynamic subtest B-HDMI-A2: SUCCESS (5.722s) [592.767906] Starting dynamic subtest: C-HDMI-A2 [598.407809] Dynamic subtest C-HDMI-A2: SUCCESS (5.666s) [598.410319] Subtest plain-flip-ts-check: SUCCESS (34.524s) [599.078920] [142/156] (480s left) api_intel_bb (add-remove-objects) [599.187316] Starting subtest: add-remove-objects [599.199071] Subtest add-remove-objects: SUCCESS (0.012s) [599.362650] [143/156] (480s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [599.577447] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [599.581112] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s) [599.744560] [144/156] (480s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [599.932766] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [599.935446] Starting dynamic subtest: pipe-A [600.252578] Dynamic subtest pipe-A: SUCCESS (0.323s) [600.292436] Starting dynamic subtest: pipe-B [600.703624] Dynamic subtest pipe-B: SUCCESS (0.448s) [600.758277] Starting dynamic subtest: pipe-C [600.785484] Dynamic subtest pipe-C: SUCCESS (0.078s) [600.787518] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.861s) [601.290763] [145/156] (478s left) gem_userptr_blits (map-fixed-invalidate) [601.436390] Starting subtest: map-fixed-invalidate [601.437948] Starting dynamic subtest: gtt [601.686941] Dynamic subtest gtt: SUCCESS (0.250s) [601.723290] Starting dynamic subtest: wb [601.856849] Dynamic subtest wb: SUCCESS (0.166s) [601.891376] Starting dynamic subtest: wc [602.027042] Dynamic subtest wc: SUCCESS (0.168s) [602.060785] Starting dynamic subtest: uc [602.199593] Dynamic subtest uc: SUCCESS (0.166s) [602.201369] Subtest map-fixed-invalidate: SUCCESS (0.766s) [602.389536] [146/156] (477s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [602.601653] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [602.606706] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [602.787848] [147/156] (477s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-rte) [603.005740] Starting subtest: fbcpsrhdr-1p-rte [603.010931] Subtest fbcpsrhdr-1p-rte: SKIP (0.000s) [603.173469] [148/156] (477s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [603.372151] Starting subtest: fbc-rgb101010-draw-mmap-cpu [604.299407] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (0.928s) [604.603806] [149/156] (475s left) kms_cursor_legacy (single-bo) [604.802853] Starting subtest: single-bo [604.806298] Starting dynamic subtest: pipe-A [610.210998] Dynamic subtest pipe-A: SUCCESS (5.403s) [610.252366] Starting dynamic subtest: pipe-B [615.626317] Dynamic subtest pipe-B: SUCCESS (5.411s) [615.657285] Starting dynamic subtest: pipe-C [621.034678] Dynamic subtest pipe-C: SUCCESS (5.400s) [621.079347] Starting dynamic subtest: all-pipes [626.437100] Dynamic subtest all-pipes: SUCCESS (5.395s) [626.439806] Subtest single-bo: SUCCESS (21.629s) [626.632685] [150/156] (453s left) kms_atomic (plane-primary-legacy) [626.836439] Starting subtest: plane-primary-legacy [626.839767] Starting dynamic subtest: pipe-A-HDMI-A-1 [627.486480] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.641s) [627.490031] Subtest plane-primary-legacy: SUCCESS (0.648s) [627.844083] [151/156] (452s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [627.963644] Starting subtest: multi-wait-for-submit-unsubmitted [628.071983] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.107s) [628.232558] [152/156] (452s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [628.437278] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [628.442471] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.001s) [628.597268] [153/156] (452s left) i915_pm_rps (thresholds) [628.726320] Starting subtest: thresholds [628.728281] Starting dynamic subtest: gt0 [638.833849] Dynamic subtest gt0: SUCCESS (10.103s) [638.841470] Subtest thresholds: SUCCESS (10.109s) [639.000816] [154/156] (441s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite) [639.212017] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite [639.217344] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s) [639.369105] [155/156] (441s left) gem_eio (wait-10ms) [639.506293] Starting subtest: wait-10ms [639.678304] Subtest wait-10ms: SUCCESS (0.170s) [639.919080] [156/156] (441s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [640.138131] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [643.076462] Subtest fbc-2p-primscrn-spr-indfb-onoff: SUCCESS (2.936s) [643.342539] Closing watchdogs results: parsing output: 0/ for test: gem_workarounds results: parsing output: 1/ for test: kms_cursor_crc results: parsing output: 2/ for test: kms_color results: parsing output: 3/ for test: kms_psr2_sf results: parsing output: 4/ for test: kms_psr results: parsing output: 5/ for test: template results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: i915_suspend results: parsing output: 8/ for test: prime_busy results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_exec_fence results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: i915_query results: parsing output: 14/ for test: kms_plane_scaling results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_content_protection results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gen9_exec_parse results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_cursor_crc results: parsing output: 21/ for test: syncobj_timeline results: parsing output: 22/ for test: kms_flip results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: gem_exec_schedule results: parsing output: 25/ for test: gem_exec_balancer results: parsing output: 26/ for test: gem_render_copy results: parsing output: 27/ for test: gem_exec_balancer results: parsing output: 28/ for test: kms_feature_discovery results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_plane_alpha_blend results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_plane results: parsing output: 35/ for test: gem_mmap_gtt results: parsing output: 36/ for test: kms_flip results: parsing output: 37/ for test: kms_universal_plane results: parsing output: 38/ for test: gem_exec_schedule results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_chamelium_color results: parsing output: 41/ for test: syncobj_wait results: parsing output: 42/ for test: gem_sync results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: syncobj_timeline results: parsing output: 46/ for test: kms_ccs results: parsing output: 47/ for test: gem_mmap_gtt results: parsing output: 48/ for test: syncobj_wait results: parsing output: 49/ for test: perf results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_big_fb results: parsing output: 52/ for test: kms_ccs results: parsing output: 53/ for test: kms_ccs results: parsing output: 54/ for test: kms_cursor_legacy results: parsing output: 55/ for test: gem_ctx_persistence results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: gem_cs_tlb results: parsing output: 58/ for test: kms_chamelium_hpd results: parsing output: 59/ for test: gem_eio results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gem_mmap results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: perf_pmu results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: kms_cursor_legacy results: parsing output: 68/ for test: gem_ctx_param results: parsing output: 69/ for test: kms_setmode results: parsing output: 70/ for test: kms_busy results: parsing output: 71/ for test: gem_exec_reloc results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: gem_exec_capture results: parsing output: 74/ for test: gem_exec_whisper results: parsing output: 75/ for test: syncobj_timeline results: parsing output: 76/ for test: gen7_exec_parse results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_async_flips results: parsing output: 79/ for test: kms_psr2_sf results: parsing output: 80/ for test: kms_ccs results: parsing output: 81/ for test: kms_flip_scaled_crc results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_lease results: parsing output: 84/ for test: gem_softpin results: parsing output: 85/ for test: kms_psr results: parsing output: 86/ for test: kms_plane results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gem_softpin results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: gem_userptr_blits results: parsing output: 93/ for test: gem_userptr_blits results: parsing output: 94/ for test: vgem_basic results: parsing output: 95/ for test: gem_render_copy results: parsing output: 96/ for test: gem_exec_reloc results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_properties results: parsing output: 99/ for test: gem_mmap_gtt results: parsing output: 100/ for test: kms_atomic_transition results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: core_getstats results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: gem_mmap_wc results: parsing output: 107/ for test: kms_pm_dc results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: drm_read results: parsing output: 110/ for test: device_reset results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_flip_scaled_crc results: parsing output: 113/ for test: kms_joiner results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: syncobj_wait results: parsing output: 116/ for test: gem_userptr_blits results: parsing output: 117/ for test: gem_lmem_swapping results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_getfb results: parsing output: 120/ for test: kms_pm_rpm results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: gem_userptr_blits results: parsing output: 125/ for test: gem_exec_parallel results: parsing output: 126/ for test: kms_big_fb results: parsing output: 127/ for test: kms_cursor_edge_walk results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: gem_barrier_race results: parsing output: 130/ for test: kms_properties results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_psr_stress_test results: parsing output: 133/ for test: gem_exec_reloc results: parsing output: 134/ for test: gem_mmap_offset results: parsing output: 135/ for test: kms_psr results: parsing output: 136/ for test: kms_ccs results: parsing output: 137/ for test: kms_vblank results: parsing output: 138/ for test: gem_ctx_persistence results: parsing output: 139/ for test: i915_drm_fdinfo results: parsing output: 140/ for test: kms_flip results: parsing output: 141/ for test: api_intel_bb results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: kms_plane_scaling results: parsing output: 144/ for test: gem_userptr_blits results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_cursor_legacy results: parsing output: 149/ for test: kms_atomic results: parsing output: 150/ for test: syncobj_wait results: parsing output: 151/ for test: kms_big_fb results: parsing output: 152/ for test: i915_pm_rps results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: gem_eio results: parsing output: 155/ for test: kms_frontbuffer_tracking Done.