[65.535136] Initializing watchdogs [65.535204] /dev/watchdog0 [65.556303] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [65.567219] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [65.571118] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [65.573809] [001/133] (960s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [65.651678] Starting subtest: y-tiled-to-vebox-yf-tiled [65.653718] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [65.899723] [002/133] (960s left) kms_flip (nonexisting-fb-interruptible) [67.416337] Starting subtest: nonexisting-fb-interruptible [67.422365] Starting dynamic subtest: A-HDMI-A3 [67.718841] Dynamic subtest A-HDMI-A3: SUCCESS (0.296s) [67.726623] Starting dynamic subtest: B-HDMI-A3 [67.882476] Dynamic subtest B-HDMI-A3: SUCCESS (0.163s) [67.890181] Starting dynamic subtest: C-HDMI-A3 [68.047429] Dynamic subtest C-HDMI-A3: SUCCESS (0.164s) [68.055158] Starting dynamic subtest: D-HDMI-A3 [68.212408] Dynamic subtest D-HDMI-A3: SUCCESS (0.164s) [68.213399] Subtest nonexisting-fb-interruptible: SUCCESS (0.795s) [68.440554] [003/133] (957s left) kms_content_protection (uevent-hdcp14) [70.016800] Starting subtest: uevent-hdcp14 [70.020411] Subtest uevent-hdcp14: SKIP (0.002s) [70.198507] [004/133] (956s left) gem_close_race (multigpu-basic-threads) [70.316452] Starting subtest: multigpu-basic-threads [70.318439] Subtest multigpu-basic-threads: SKIP (0.000s) [70.589365] [005/133] (955s left) tools_test (tools_test) [70.638782] Starting subtest: tools_test [70.715990] Subtest tools_test: SUCCESS (0.083s) [70.783019] [006/133] (955s left) gem_mmap_gtt (bad-object) [70.854896] Subtest bad-object: SKIP (0.000s) [70.936125] [007/133] (955s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [71.006908] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [71.007900] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s) [71.146736] [008/133] (955s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [72.652914] Starting subtest: fbc-indfb-scaledprimary [74.174073] Subtest fbc-indfb-scaledprimary: SUCCESS (1.521s) [74.412787] [009/133] (952s left) prime_mmap (test_refcounting) [74.488139] Starting subtest: test_refcounting [74.489053] Starting dynamic subtest: test_refcounting-smem [74.538368] Dynamic subtest test_refcounting-smem: SUCCESS (0.050s) [74.546376] Starting dynamic subtest: test_refcounting-lmem0 [74.735550] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.197s) [74.736462] Subtest test_refcounting: SUCCESS (0.247s) [74.855917] [010/133] (951s left) gem_ctx_shared (q-in-order) [74.947975] Starting subtest: Q-in-order [74.948911] Starting dynamic subtest: rcs0 [75.249729] Dynamic subtest rcs0: SUCCESS (0.301s) [75.258796] Starting dynamic subtest: bcs0 [75.429053] Dynamic subtest bcs0: SUCCESS (0.179s) [75.437824] Starting dynamic subtest: vcs0 [75.619640] Dynamic subtest vcs0: SUCCESS (0.190s) [75.628533] Starting dynamic subtest: vcs1 [75.808989] Dynamic subtest vcs1: SUCCESS (0.189s) [75.818401] Starting dynamic subtest: vecs0 [75.998577] Dynamic subtest vecs0: SUCCESS (0.189s) [76.007472] Starting dynamic subtest: vecs1 [76.188740] Dynamic subtest vecs1: SUCCESS (0.190s) [76.197528] Starting dynamic subtest: ccs0 [76.378766] Dynamic subtest ccs0: SUCCESS (0.190s) [76.379634] Subtest Q-in-order: SUCCESS (1.430s) [76.704419] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true [76.706283] [011/133] (950s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [78.218982] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [78.219861] Starting dynamic subtest: pipe-A-HDMI-A-3 [78.228412] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [78.236877] Starting dynamic subtest: pipe-B-HDMI-A-3 [78.245407] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [78.253619] Starting dynamic subtest: pipe-C-HDMI-A-3 [78.262154] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [78.270221] Starting dynamic subtest: pipe-D-HDMI-A-3 [78.278982] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [78.280806] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [78.480790] [012/133] (948s left) gem_exec_fence (submit-chain) [78.685318] Starting subtest: submit-chain [78.739977] Subtest submit-chain: SUCCESS (0.055s) [79.410397] [013/133] (947s left) syncobj_timeline (transfer-timeline-point) [79.489124] Starting subtest: transfer-timeline-point [79.490189] Subtest transfer-timeline-point: SUCCESS (0.001s) [79.680549] [014/133] (947s left) kms_psr (psr-primary-mmap-cpu) [81.191735] Subtest psr-primary-mmap-cpu: SKIP (0.000s) [81.252709] [015/133] (945s left) api_intel_bb (render) [81.330947] Starting subtest: render [81.331884] Starting dynamic subtest: render-none-512 [81.380199] Dynamic subtest render-none-512: SUCCESS (0.050s) [81.388691] Starting dynamic subtest: render-none-1024 [81.454253] Dynamic subtest render-none-1024: SUCCESS (0.074s) [81.463181] Starting dynamic subtest: render-x-512 [81.473062] Dynamic subtest render-x-512: SUCCESS (0.019s) [81.481559] Starting dynamic subtest: render-x-1024 [81.541596] Dynamic subtest render-x-1024: SUCCESS (0.068s) [81.550096] Starting dynamic subtest: render-y-512 [81.559978] Dynamic subtest render-y-512: SUCCESS (0.018s) [81.568497] Starting dynamic subtest: render-y-1024 [81.623989] Dynamic subtest render-y-1024: SUCCESS (0.063s) [81.624824] Subtest render: SUCCESS (0.293s) [81.797390] [016/133] (945s left) gem_spin_batch (legacy-resubmit-new) [81.890532] Starting subtest: legacy-resubmit-new [81.891472] Starting dynamic subtest: default [81.924800] Dynamic subtest default: SUCCESS (0.034s) [81.934041] Starting dynamic subtest: render [81.934966] Dynamic subtest render: SUCCESS (0.004s) [81.945202] Starting dynamic subtest: bsd [81.946184] Dynamic subtest bsd: SUCCESS (0.007s) [81.955151] Starting dynamic subtest: bsd1 [81.956117] Dynamic subtest bsd1: SUCCESS (0.006s) [81.964700] Starting dynamic subtest: bsd2 [81.965533] Dynamic subtest bsd2: SUCCESS (0.006s) [81.974069] Starting dynamic subtest: blt [81.975117] Dynamic subtest blt: SUCCESS (0.005s) [81.983585] Starting dynamic subtest: vebox [81.984743] Dynamic subtest vebox: SUCCESS (0.005s) [81.985838] Subtest legacy-resubmit-new: SUCCESS (0.069s) [82.249157] [017/133] (944s left) vgem_basic (dmabuf-fence-before) [82.306214] Starting subtest: dmabuf-fence-before [82.307162] Subtest dmabuf-fence-before: SUCCESS (0.000s) [82.406093] [018/133] (944s left) syncobj_timeline (etime-single-wait-all-submitted) [82.487950] Starting subtest: etime-single-wait-all-submitted [82.590621] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s) [82.699497] [019/133] (944s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt) [84.216672] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt [84.218285] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [84.400018] [020/133] (942s left) kms_big_fb (x-tiled-64bpp-rotate-0) [85.934254] Starting subtest: x-tiled-64bpp-rotate-0 [87.807269] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.872s) [87.993669] [021/133] (939s left) kms_pm_rpm (dpms-mode-unset-lpsp) [92.036239] Starting subtest: dpms-mode-unset-lpsp [93.048214] Subtest dpms-mode-unset-lpsp: SKIP (1.010s) [94.031755] [022/133] (933s left) kms_invalid_mode (bad-vsync-end) [95.544935] Starting subtest: bad-vsync-end [95.545876] Starting dynamic subtest: pipe-A-HDMI-A-3 [95.589146] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.044s) [95.598128] Starting dynamic subtest: pipe-B-HDMI-A-3 [95.599332] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s) [95.607898] Starting dynamic subtest: pipe-C-HDMI-A-3 [95.609110] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s) [95.617592] Starting dynamic subtest: pipe-D-HDMI-A-3 [95.618480] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s) [95.619390] Subtest bad-vsync-end: SUCCESS (0.050s) [95.764931] [023/133] (931s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [97.278228] Starting subtest: fbcpsr-farfromfence-mmap-gtt [97.280008] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [97.485912] [024/133] (930s left) kms_cursor_edge_walk (128x128-right-edge) [99.014343] Starting subtest: 128x128-right-edge [99.015261] Starting dynamic subtest: pipe-A-HDMI-A-3 [102.342206] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.328s) [102.351011] Starting dynamic subtest: pipe-D-HDMI-A-3 [105.572991] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.229s) [105.573949] Subtest 128x128-right-edge: SUCCESS (6.560s) [105.749481] [025/133] (922s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [105.833917] Starting subtest: multi-wait-for-submit-unsubmitted [105.942759] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.108s) [106.075864] [026/133] (921s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [107.590280] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [107.591969] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s) [107.712690] [027/133] (920s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [109.248400] Starting subtest: short-flip-after-cursor-toggle [110.221551] Subtest short-flip-after-cursor-toggle: SUCCESS (0.973s) [110.407918] [028/133] (917s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [111.919823] Starting subtest: 2x-flip-vs-blocking-wf-vblank [111.932354] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.013s) [112.125152] [029/133] (915s left) i915_query (query-regions-unallocated) [112.207999] Starting subtest: query-regions-unallocated [113.297647] Subtest query-regions-unallocated: SUCCESS (1.090s) [113.426112] [030/133] (914s left) kms_big_fb (4-tiled-16bpp-rotate-180) [114.950431] Starting subtest: 4-tiled-16bpp-rotate-180 [116.753912] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.803s) [116.914475] [031/133] (911s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [118.427326] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [118.428219] Starting dynamic subtest: pipe-A-HDMI-A-3 [118.436659] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [118.445557] Starting dynamic subtest: pipe-B-HDMI-A-3 [118.454280] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [118.462874] Starting dynamic subtest: pipe-C-HDMI-A-3 [118.471216] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [118.479748] Starting dynamic subtest: pipe-D-HDMI-A-3 [118.488492] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [118.490231] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s) [118.710665] [032/133] (909s left) kms_atomic_transition (plane-all-modeset-transition) [120.220256] Starting subtest: plane-all-modeset-transition [120.221132] Starting dynamic subtest: pipe-A-HDMI-A-3 [131.379084] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (11.157s) [131.432118] Starting dynamic subtest: pipe-B-HDMI-A-3 [139.164944] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (7.746s) [139.182864] Subtest plane-all-modeset-transition: SUCCESS (18.963s) [139.338100] [033/133] (888s left) kms_flip (2x-nonexisting-fb-interruptible) [140.853162] Starting subtest: 2x-nonexisting-fb-interruptible [140.866999] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.013s) [141.064086] [034/133] (887s left) gem_create (create-valid-nonaligned) [141.152051] Starting subtest: create-valid-nonaligned [141.152993] Subtest create-valid-nonaligned: SUCCESS (0.000s) [141.359495] [035/133] (887s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [142.875415] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [142.877128] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [143.011312] [036/133] (885s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs) [144.550100] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs [144.550997] Starting dynamic subtest: pipe-A-HDMI-A-3 [144.559549] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [144.568525] Starting dynamic subtest: pipe-B-HDMI-A-3 [144.577106] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [144.585867] Starting dynamic subtest: pipe-C-HDMI-A-3 [144.593917] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [144.602498] Starting dynamic subtest: pipe-D-HDMI-A-3 [144.611414] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [144.613321] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s) [144.777447] [037/133] (883s left) kms_chamelium_color (ctm-0-25) [146.293128] Subtest ctm-0-25: SKIP (0.000s) [146.343993] [038/133] (882s left) kms_flip (basic-flip-vs-wf_vblank) [147.856041] Starting subtest: basic-flip-vs-wf_vblank [147.861128] Starting dynamic subtest: A-HDMI-A3 [148.885115] Dynamic subtest A-HDMI-A3: SUCCESS (1.024s) [148.895679] Starting dynamic subtest: B-HDMI-A3 [150.017936] Dynamic subtest B-HDMI-A3: SUCCESS (1.132s) [150.027312] Starting dynamic subtest: C-HDMI-A3 [150.984113] Dynamic subtest C-HDMI-A3: SUCCESS (0.965s) [150.993472] Starting dynamic subtest: D-HDMI-A3 [151.931952] Dynamic subtest D-HDMI-A3: SUCCESS (0.947s) [151.932894] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.077s) [152.169183] [039/133] (876s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [153.679468] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [153.681270] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [153.773690] [040/133] (874s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [155.302336] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [155.303230] Starting dynamic subtest: pipe-A-HDMI-A-3 [155.324658] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s) [155.333599] Starting dynamic subtest: pipe-B-HDMI-A-3 [155.355895] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s) [155.364758] Starting dynamic subtest: pipe-C-HDMI-A-3 [155.389173] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s) [155.397890] Starting dynamic subtest: pipe-D-HDMI-A-3 [155.420207] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s) [155.421935] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.013s) [155.572291] [041/133] (873s left) gem_softpin (evict-active-interruptible) [155.659233] Starting subtest: evict-active-interruptible [155.677922] Subtest evict-active-interruptible: SUCCESS (0.019s) [155.839624] [042/133] (873s left) i915_hangman (error-state-basic) [155.941062] Starting subtest: error-state-basic [156.162144] Subtest error-state-basic: SUCCESS (0.220s) [156.250971] [043/133] (872s left) kms_psr (fbc-psr2-primary-page-flip) [157.760208] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s) [157.813765] [044/133] (871s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [159.341598] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [159.343404] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [159.476951] [045/133] (869s left) kms_lease (master-vs-lease) [161.012160] Starting subtest: master-vs-lease [161.014483] Subtest master-vs-lease: SUCCESS (0.003s) [161.238055] [046/133] (867s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [162.752976] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s) [162.813484] [047/133] (866s left) kms_psr (fbc-pr-cursor-plane-move) [164.323396] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [164.380425] [048/133] (864s left) syncobj_timeline (invalid-single-wait-unsubmitted) [164.458152] Starting subtest: invalid-single-wait-unsubmitted [164.459141] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [164.602433] [049/133] (864s left) gem_userptr_blits (input-checking) [164.685997] Starting subtest: input-checking [164.686930] Subtest input-checking: SUCCESS (0.000s) [164.855793] [050/133] (864s left) kms_getfb (getfb2-into-addfb2) [166.367394] Starting subtest: getfb2-into-addfb2 [166.368257] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [166.543701] [051/133] (862s left) kms_cursor_crc (cursor-offscreen-64x21) [168.248949] Starting subtest: cursor-offscreen-64x21 [168.253204] Starting dynamic subtest: pipe-A-HDMI-A-3 [170.676490] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.423s) [170.707053] Starting dynamic subtest: pipe-D-HDMI-A-3 [173.047957] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.349s) [173.049036] Subtest cursor-offscreen-64x21: SUCCESS (4.798s) [173.398385] [052/133] (856s left) gem_wait (write-busy) [173.497119] Starting subtest: write-busy [173.497995] Starting dynamic subtest: all-engines [174.102260] Dynamic subtest all-engines: SUCCESS (0.606s) [174.111676] Starting dynamic subtest: rcs0 [174.650954] Dynamic subtest rcs0: SUCCESS (0.548s) [174.661052] Starting dynamic subtest: bcs0 [175.196931] Dynamic subtest bcs0: SUCCESS (0.545s) [175.210944] Starting dynamic subtest: vcs0 [175.744056] Dynamic subtest vcs0: SUCCESS (0.546s) [175.753902] Starting dynamic subtest: vcs1 [176.286012] Dynamic subtest vcs1: SUCCESS (0.542s) [176.295776] Starting dynamic subtest: vecs0 [176.828137] Dynamic subtest vecs0: SUCCESS (0.542s) [176.837925] Starting dynamic subtest: vecs1 [177.369153] Dynamic subtest vecs1: SUCCESS (0.541s) [177.379136] Starting dynamic subtest: ccs0 [177.911060] Dynamic subtest ccs0: SUCCESS (0.541s) [177.911960] Subtest write-busy: SUCCESS (4.415s) [178.201062] [053/133] (851s left) sw_sync (sync_random_merge) [178.249436] Starting subtest: sync_random_merge [178.320288] Subtest sync_random_merge: SUCCESS (0.071s) [178.387439] [054/133] (851s left) kms_async_flips (crc) [179.898506] Starting subtest: crc [180.109963] Starting dynamic subtest: pipe-A-HDMI-A-3 [182.497892] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.388s) [182.668810] Starting dynamic subtest: pipe-B-HDMI-A-3 [184.851998] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.191s) [184.997955] Starting dynamic subtest: pipe-C-HDMI-A-3 [187.173535] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.184s) [187.316737] Starting dynamic subtest: pipe-D-HDMI-A-3 [189.494273] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.186s) [189.495210] Subtest crc: SUCCESS (9.597s) [189.860122] [055/133] (839s left) gem_pread (exhaustion) [189.942162] Subtest exhaustion: SKIP (0.000s) [190.050287] [056/133] (839s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [191.557172] Starting subtest: primary-yf-tiled-reflect-x-180 [191.661475] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.103s) [191.840402] [057/133] (838s left) kms_plane (pixel-format-yf-tiled-ccs-modifier) [193.352478] Starting subtest: pixel-format-yf-tiled-ccs-modifier [193.354241] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s) [193.469997] [058/133] (836s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [195.003486] Starting subtest: basic-flip-before-cursor-atomic [196.001268] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.998s) [196.205117] [059/133] (833s left) syncobj_wait (invalid-reset-one-illegal-handle) [196.288173] Starting subtest: invalid-reset-one-illegal-handle [196.289134] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [196.459599] [060/133] (833s left) kms_psr (psr2-primary-mmap-gtt) [197.972310] Subtest psr2-primary-mmap-gtt: SKIP (0.000s) [198.026214] [061/133] (832s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [199.542322] Starting subtest: fbcpsr-slowdraw [199.544163] Subtest fbcpsr-slowdraw: SKIP (0.000s) [199.667806] [062/133] (830s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [201.208089] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [201.209955] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [201.364762] [063/133] (829s left) kms_psr (pr-dpms) [202.912956] Subtest pr-dpms: SKIP (0.000s) [202.976814] [064/133] (827s left) kms_vblank (wait-forked-hang) [204.496506] Starting subtest: wait-forked-hang [204.497421] Starting dynamic subtest: pipe-A-HDMI-A-3 [230.573915] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.076s) [230.585055] Starting dynamic subtest: pipe-D-HDMI-A-3 [255.506557] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (24.930s) [255.507458] Subtest wait-forked-hang: SUCCESS (51.012s) [255.654649] [065/133] (774s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [257.166461] Starting subtest: cursorB-vs-flipB-atomic-transitions [257.168159] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [257.258246] [066/133] (773s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [258.794250] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [259.888176] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.094s) [260.132597] [067/133] (770s left) gem_lmem_swapping (heavy-verify-multi) [264.467385] Starting subtest: heavy-verify-multi [264.468276] Starting dynamic subtest: lmem0 [278.092961] Dynamic subtest lmem0: SUCCESS (13.625s) [278.094128] Subtest heavy-verify-multi: SUCCESS (13.626s) [279.172876] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [279.173905] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: kernel.kmod_is_loaded.i915: true [279.176165] [068/133] (751s left) prime_vgem (wait) [282.624564] Starting subtest: wait [282.625412] Starting dynamic subtest: rcs0 [282.677751] Dynamic subtest rcs0: SUCCESS (0.053s) [282.688211] Starting dynamic subtest: bcs0 [282.730362] Dynamic subtest bcs0: SUCCESS (0.052s) [282.741410] Starting dynamic subtest: vcs0 [282.772214] Dynamic subtest vcs0: SUCCESS (0.041s) [282.794700] Starting dynamic subtest: vcs1 [282.817138] Dynamic subtest vcs1: SUCCESS (0.043s) [282.840779] Starting dynamic subtest: vecs0 [282.857880] Dynamic subtest vecs0: SUCCESS (0.039s) [282.872579] Starting dynamic subtest: vecs1 [282.901198] Dynamic subtest vecs1: SUCCESS (0.042s) [282.916037] Starting dynamic subtest: ccs0 [282.944982] Dynamic subtest ccs0: SUCCESS (0.043s) [282.946137] Subtest wait: SUCCESS (0.321s) [283.096666] [FACT prime_vgem (wait)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [283.099254] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.i915: true [283.101738] [069/133] (747s left) vgem_basic (unload) [283.150419] Starting subtest: unload [312.121639] Subtest unload: SUCCESS (28.970s) [312.245098] [070/133] (718s left) gem_exec_whisper (basic-fds-priority) [312.337446] Starting subtest: basic-fds-priority [335.061520] Subtest basic-fds-priority: SUCCESS (22.723s) [335.300851] [071/133] (695s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [336.818776] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [336.820443] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [336.972202] [072/133] (694s left) gem_exec_schedule (noreorder) [337.238929] Starting subtest: noreorder [337.240809] Starting dynamic subtest: rcs0 [337.342374] Dynamic subtest rcs0: SUCCESS (0.105s) [337.352541] Starting dynamic subtest: bcs0 [337.397453] Dynamic subtest bcs0: SUCCESS (0.054s) [337.415890] Starting dynamic subtest: vcs0 [337.461766] Dynamic subtest vcs0: SUCCESS (0.063s) [337.493194] Starting dynamic subtest: vcs1 [337.543041] Dynamic subtest vcs1: SUCCESS (0.079s) [337.575323] Starting dynamic subtest: vecs0 [337.624473] Dynamic subtest vecs0: SUCCESS (0.080s) [337.653072] Starting dynamic subtest: vecs1 [337.700823] Dynamic subtest vecs1: SUCCESS (0.075s) [337.715777] Starting dynamic subtest: ccs0 [337.748407] Dynamic subtest ccs0: SUCCESS (0.046s) [337.749495] Subtest noreorder: SUCCESS (0.513s) [338.073805] [073/133] (693s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75) [339.592711] Starting subtest: planes-unity-scaling-downscale-factor-0-75 [339.593568] Starting dynamic subtest: pipe-A [339.696999] Dynamic subtest pipe-A: SUCCESS (0.105s) [339.710867] Starting dynamic subtest: pipe-B [339.842699] Dynamic subtest pipe-B: SUCCESS (0.145s) [339.853483] Starting dynamic subtest: pipe-C [339.967679] Dynamic subtest pipe-C: SUCCESS (0.124s) [339.977268] Starting dynamic subtest: pipe-D [340.093396] Dynamic subtest pipe-D: SUCCESS (0.125s) [340.094337] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.502s) [340.277826] [074/133] (690s left) gem_exec_params (invalid-bsd-ring) [340.360606] Starting subtest: invalid-bsd-ring [340.361486] Subtest invalid-bsd-ring: SUCCESS (0.000s) [340.494151] [075/133] (690s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [342.010533] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [342.012324] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [342.240281] [076/133] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [343.758912] Starting subtest: fbcpsr-2p-rte [343.760574] Subtest fbcpsr-2p-rte: SKIP (0.000s) [343.889831] [077/133] (687s left) gem_ctx_persistence (legacy-engines-persistence) [344.013192] Starting subtest: legacy-engines-persistence [344.014154] Starting dynamic subtest: render [344.829543] Dynamic subtest render: SUCCESS (0.816s) [344.841506] Starting dynamic subtest: bsd1 [345.598571] Dynamic subtest bsd1: SUCCESS (0.767s) [345.611914] Starting dynamic subtest: bsd2 [346.366097] Dynamic subtest bsd2: SUCCESS (0.765s) [346.378572] Starting dynamic subtest: blt [347.132260] Dynamic subtest blt: SUCCESS (0.763s) [347.144628] Starting dynamic subtest: vebox [347.898954] Dynamic subtest vebox: SUCCESS (0.763s) [347.900623] Subtest legacy-engines-persistence: SUCCESS (3.887s) [348.047776] [078/133] (683s left) kms_plane_cursor (viewport) [349.561679] Starting subtest: viewport [349.563466] Starting dynamic subtest: pipe-A-HDMI-A-3-size-64 [352.852227] Dynamic subtest pipe-A-HDMI-A-3-size-64: SUCCESS (3.289s) [352.928703] Starting dynamic subtest: pipe-A-HDMI-A-3-size-128 [356.202072] Dynamic subtest pipe-A-HDMI-A-3-size-128: SUCCESS (3.283s) [356.280714] Starting dynamic subtest: pipe-A-HDMI-A-3-size-256 [359.502444] Dynamic subtest pipe-A-HDMI-A-3-size-256: SUCCESS (3.233s) [359.626317] Starting dynamic subtest: pipe-B-HDMI-A-3-size-64 [362.953334] Dynamic subtest pipe-B-HDMI-A-3-size-64: SUCCESS (3.340s) [363.029015] Starting dynamic subtest: pipe-B-HDMI-A-3-size-128 [366.253827] Dynamic subtest pipe-B-HDMI-A-3-size-128: SUCCESS (3.249s) [366.314875] Starting dynamic subtest: pipe-B-HDMI-A-3-size-256 [369.470681] Dynamic subtest pipe-B-HDMI-A-3-size-256: SUCCESS (3.167s) [369.558541] Starting dynamic subtest: pipe-C-HDMI-A-3-size-64 [372.774994] Dynamic subtest pipe-C-HDMI-A-3-size-64: SUCCESS (3.227s) [372.833658] Starting dynamic subtest: pipe-C-HDMI-A-3-size-128 [376.091928] Dynamic subtest pipe-C-HDMI-A-3-size-128: SUCCESS (3.267s) [376.166731] Starting dynamic subtest: pipe-C-HDMI-A-3-size-256 [379.340636] Dynamic subtest pipe-C-HDMI-A-3-size-256: SUCCESS (3.199s) [379.426778] Starting dynamic subtest: pipe-D-HDMI-A-3-size-64 [382.608604] Dynamic subtest pipe-D-HDMI-A-3-size-64: SUCCESS (3.190s) [382.666639] Starting dynamic subtest: pipe-D-HDMI-A-3-size-128 [385.841999] Dynamic subtest pipe-D-HDMI-A-3-size-128: SUCCESS (3.184s) [385.916166] Starting dynamic subtest: pipe-D-HDMI-A-3-size-256 [389.175454] Dynamic subtest pipe-D-HDMI-A-3-size-256: SUCCESS (3.283s) [389.267298] Subtest viewport: SUCCESS (39.705s) [389.449652] [079/133] (642s left) gem_exec_fence (concurrent) [389.663204] Starting subtest: concurrent [389.665442] Subtest concurrent: SKIP (0.000s) [390.409875] [080/133] (641s left) gem_mmap_gtt (medium-copy-odd) [390.489244] Subtest medium-copy-odd: SKIP (0.000s) [390.564692] [081/133] (641s left) gem_exec_parallel (userptr) [390.652586] Starting subtest: userptr [390.653464] Starting dynamic subtest: rcs0 [392.607542] Dynamic subtest rcs0: SUCCESS (1.954s) [392.619160] Starting dynamic subtest: bcs0 [394.063428] Dynamic subtest bcs0: SUCCESS (1.455s) [394.076210] Starting dynamic subtest: vcs0 [395.608371] Dynamic subtest vcs0: SUCCESS (1.544s) [395.620041] Starting dynamic subtest: vcs1 [397.111340] Dynamic subtest vcs1: SUCCESS (1.502s) [397.122742] Starting dynamic subtest: vecs0 [398.599652] Dynamic subtest vecs0: SUCCESS (1.487s) [398.610703] Starting dynamic subtest: vecs1 [400.067571] Dynamic subtest vecs1: SUCCESS (1.467s) [400.079487] Starting dynamic subtest: ccs0 [401.528365] Dynamic subtest ccs0: SUCCESS (1.459s) [401.529399] Subtest userptr: SUCCESS (10.876s) [401.811970] [082/133] (629s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [404.422358] Starting subtest: verify-pxp-execution-after-suspend-resume [404.424431] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s) [404.529547] [083/133] (627s left) kms_cursor_crc (cursor-random-512x512) [406.312250] Starting subtest: cursor-random-512x512 [406.314318] Subtest cursor-random-512x512: SKIP (0.001s) [406.578344] [084/133] (625s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [408.088309] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [408.148425] [085/133] (623s left) gem_mmap_gtt (hang) [408.229221] Subtest hang: SKIP (0.000s) [408.299683] [086/133] (623s left) gem_exec_schedule (u-semaphore-noskip) [408.398435] Starting subtest: u-semaphore-noskip [409.147534] Subtest u-semaphore-noskip: SUCCESS (0.750s) [409.582484] [087/133] (622s left) kms_big_fb (linear-16bpp-rotate-180) [411.106749] Starting subtest: linear-16bpp-rotate-180 [412.972139] Subtest linear-16bpp-rotate-180: SUCCESS (1.866s) [413.147045] [088/133] (618s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [414.664008] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [417.238729] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.576s) [417.435207] [089/133] (614s left) gem_mmap_offset (isolation) [417.514528] Starting subtest: isolation [417.523129] Subtest isolation: SUCCESS (0.008s) [417.700298] [090/133] (614s left) gem_fence_thrash (bo-write-verify-none) [417.749070] Starting subtest: bo-write-verify-none [417.781262] Subtest bo-write-verify-none: SKIP (0.031s) [417.848418] [091/133] (614s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [419.366185] Starting subtest: psr-rgb101010-draw-mmap-cpu [419.367938] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [419.525883] [092/133] (612s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [421.071971] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [424.222278] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.151s) [424.385222] [093/133] (608s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt) [425.902070] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt [425.903831] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [426.018470] [094/133] (606s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [427.547038] Starting subtest: coverage-vs-premult-vs-constant [427.797400] Starting dynamic subtest: pipe-A-HDMI-A-3 [428.212196] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.413s) [428.222321] Starting dynamic subtest: pipe-D-HDMI-A-3 [428.598928] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.386s) [428.599913] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.053s) [428.796982] [095/133] (603s left) kms_chamelium_frames (hdmi-crc-single) [430.365401] Subtest hdmi-crc-single: SKIP (0.000s) [430.465466] [096/133] (602s left) kms_addfb_basic (no-handle) [430.550571] Starting subtest: no-handle [430.551451] Subtest no-handle: SUCCESS (0.000s) [432.237205] [097/133] (600s left) gem_wait (invalid-buf) [432.323660] Starting subtest: invalid-buf [432.324552] Subtest invalid-buf: SUCCESS (0.000s) [432.642583] [098/133] (600s left) i915_drm_fdinfo (basics) [432.713554] Starting subtest: basics [432.714467] Subtest basics: SUCCESS (0.000s) [432.858273] [099/133] (600s left) perf_pmu (busy-double-start) [432.929689] Starting subtest: busy-double-start [432.930589] Starting dynamic subtest: rcs0 [436.552353] Dynamic subtest rcs0: SUCCESS (3.622s) [436.566266] Starting dynamic subtest: bcs0 [440.143346] Dynamic subtest bcs0: SUCCESS (3.589s) [440.157329] Starting dynamic subtest: vcs0 [443.746060] Dynamic subtest vcs0: FAIL (3.578s) [443.757715] Starting dynamic subtest: vcs1 [447.315262] Dynamic subtest vcs1: FAIL (3.565s) [447.327717] Starting dynamic subtest: vecs0 [450.879406] Dynamic subtest vecs0: FAIL (3.564s) [450.891723] Starting dynamic subtest: vecs1 [454.449094] Dynamic subtest vecs1: FAIL (3.565s) [454.463388] Starting dynamic subtest: ccs0 [458.004101] Dynamic subtest ccs0: SUCCESS (3.579s) [458.009035] Subtest busy-double-start: FAIL (25.076s) [458.150828] [100/133] (574s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [459.673280] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [459.675278] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [459.909679] [101/133] (573s left) syncobj_wait (invalid-multi-wait-unsubmitted) [459.989429] Starting subtest: invalid-multi-wait-unsubmitted [459.990324] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [460.137583] [102/133] (573s left) gem_ctx_persistence (engines-mixed) [460.225451] Starting subtest: engines-mixed [460.226382] Starting dynamic subtest: rcs0 [460.319554] Dynamic subtest rcs0: SUCCESS (0.093s) [460.332455] Starting dynamic subtest: bcs0 [460.362320] Dynamic subtest bcs0: SUCCESS (0.041s) [460.375982] Starting dynamic subtest: vcs0 [460.409491] Dynamic subtest vcs0: SUCCESS (0.046s) [460.427285] Starting dynamic subtest: vcs1 [460.466033] Dynamic subtest vcs1: SUCCESS (0.055s) [460.503730] Starting dynamic subtest: vecs0 [460.535543] Dynamic subtest vecs0: SUCCESS (0.067s) [460.555836] Starting dynamic subtest: vecs1 [460.591312] Dynamic subtest vecs1: SUCCESS (0.054s) [460.614740] Starting dynamic subtest: ccs0 [460.643386] Dynamic subtest ccs0: SUCCESS (0.050s) [460.647283] Subtest engines-mixed: SUCCESS (0.419s) [460.828660] [103/133] (572s left) gen9_exec_parse (basic-rejected) [460.918427] Subtest basic-rejected: SKIP (0.000s) [461.003660] [104/133] (572s left) vgem_basic (busy-fence) [461.066700] Starting subtest: busy-fence [461.067557] Subtest busy-fence: SUCCESS (0.000s) [461.155448] [105/133] (572s left) kms_draw_crc (draw-method-blt) [462.668167] Starting subtest: draw-method-blt [462.669143] Starting dynamic subtest: xrgb8888-untiled [463.050032] Dynamic subtest xrgb8888-untiled: SUCCESS (0.381s) [463.085812] Starting dynamic subtest: rgb565-untiled [463.383070] Dynamic subtest rgb565-untiled: SUCCESS (0.329s) [463.420065] Starting dynamic subtest: xrgb2101010-untiled [463.683151] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.296s) [463.722222] Starting dynamic subtest: xbgr16161616f-untiled [463.999945] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.313s) [464.040075] Starting dynamic subtest: xrgb8888-xtiled [464.166984] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.163s) [464.203281] Starting dynamic subtest: rgb565-xtiled [464.333439] Dynamic subtest rgb565-xtiled: SUCCESS (0.162s) [464.371582] Starting dynamic subtest: xrgb2101010-xtiled [464.483246] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.146s) [464.522957] Starting dynamic subtest: xbgr16161616f-xtiled [464.633167] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.146s) [464.670674] Starting dynamic subtest: xrgb8888-4tiled [464.800155] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.163s) [464.838952] Starting dynamic subtest: rgb565-4tiled [464.966876] Dynamic subtest rgb565-4tiled: SUCCESS (0.163s) [465.004369] Starting dynamic subtest: xrgb2101010-4tiled [465.116662] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.146s) [465.152241] Starting dynamic subtest: xbgr16161616f-4tiled [465.266610] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.146s) [465.271627] Subtest draw-method-blt: SUCCESS (2.601s) [465.444093] [106/133] (568s left) gem_exec_balancer (hog) [465.532871] Starting subtest: hog [465.535154] Subtest hog: SKIP (0.000s) [465.955686] [107/133] (567s left) api_intel_allocator (alloc-simple) [466.038535] Starting subtest: alloc-simple [466.064776] Subtest alloc-simple: SUCCESS (0.027s) [466.261907] [108/133] (567s left) kms_cursor_legacy (torture-bo) [467.779961] Starting subtest: torture-bo [467.780903] Starting dynamic subtest: pipe-A [473.379152] Dynamic subtest pipe-A: SUCCESS (5.607s) [473.390108] Starting dynamic subtest: pipe-B [478.925225] Dynamic subtest pipe-B: SUCCESS (5.544s) [478.935588] Starting dynamic subtest: pipe-C [484.699188] Dynamic subtest pipe-C: SUCCESS (5.774s) [484.709742] Starting dynamic subtest: pipe-D [490.506202] Dynamic subtest pipe-D: SUCCESS (5.805s) [490.518437] Starting dynamic subtest: all-pipes [495.981631] Dynamic subtest all-pipes: SUCCESS (5.474s) [495.982503] Subtest torture-bo: SUCCESS (28.210s) [496.117664] [109/133] (537s left) gem_exec_params (cliprects-invalid) [496.236316] Starting subtest: cliprects-invalid [496.237237] Subtest cliprects-invalid: SUCCESS (0.000s) [496.387606] [110/133] (537s left) prime_mmap (test_dup) [496.467630] Starting subtest: test_dup [496.468514] Starting dynamic subtest: test_dup-smem [496.517331] Dynamic subtest test_dup-smem: SUCCESS (0.049s) [496.529237] Starting dynamic subtest: test_dup-lmem0 [496.717581] Dynamic subtest test_dup-lmem0: SUCCESS (0.199s) [496.718531] Subtest test_dup: SUCCESS (0.250s) [496.856898] [111/133] (537s left) kms_flip (bo-too-big-interruptible) [498.374438] Starting subtest: bo-too-big-interruptible [498.379370] Starting dynamic subtest: A-HDMI-A3 [498.611025] Dynamic subtest A-HDMI-A3: SUCCESS (0.231s) [498.638651] Starting dynamic subtest: B-HDMI-A3 [498.759567] Dynamic subtest B-HDMI-A3: SUCCESS (0.146s) [498.773073] Starting dynamic subtest: C-HDMI-A3 [498.893017] Dynamic subtest C-HDMI-A3: SUCCESS (0.132s) [498.906221] Starting dynamic subtest: D-HDMI-A3 [499.025485] Dynamic subtest D-HDMI-A3: SUCCESS (0.131s) [499.026414] Subtest bo-too-big-interruptible: SUCCESS (0.653s) [499.257890] [112/133] (534s left) kms_busy (extended-pageflip-hang-oldfb) [500.779390] Starting subtest: extended-pageflip-hang-oldfb [500.781511] Starting dynamic subtest: pipe-A [500.975787] Dynamic subtest pipe-A: SUCCESS (0.194s) [500.993012] Starting dynamic subtest: pipe-D [501.146617] Dynamic subtest pipe-D: SUCCESS (0.167s) [501.147506] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.368s) [501.322599] [113/133] (532s left) i915_pm_rps (fence-order) [501.412801] Starting subtest: fence-order [505.804947] Subtest fence-order: SUCCESS (4.391s) [505.976596] [114/133] (528s left) kms_plane (plane-position-hole-dpms) [507.487062] Starting subtest: plane-position-hole-dpms [507.904489] Starting dynamic subtest: pipe-A-plane-1 [508.393506] Dynamic subtest pipe-A-plane-1: SUCCESS (0.489s) [508.405629] Starting dynamic subtest: pipe-A-plane-2 [508.884663] Dynamic subtest pipe-A-plane-2: SUCCESS (0.490s) [508.895561] Starting dynamic subtest: pipe-A-plane-3 [509.375639] Dynamic subtest pipe-A-plane-3: SUCCESS (0.490s) [509.386777] Starting dynamic subtest: pipe-A-plane-4 [509.852388] Dynamic subtest pipe-A-plane-4: SUCCESS (0.474s) [509.864392] Starting dynamic subtest: pipe-A-plane-5 [509.873195] Dynamic subtest pipe-A-plane-5: SUCCESS (0.020s) [510.144168] Starting dynamic subtest: pipe-B-plane-1 [510.580946] Dynamic subtest pipe-B-plane-1: SUCCESS (0.446s) [510.592123] Starting dynamic subtest: pipe-B-plane-2 [511.025340] Dynamic subtest pipe-B-plane-2: SUCCESS (0.444s) [511.036418] Starting dynamic subtest: pipe-B-plane-3 [511.471303] Dynamic subtest pipe-B-plane-3: SUCCESS (0.445s) [511.482503] Starting dynamic subtest: pipe-B-plane-4 [511.915327] Dynamic subtest pipe-B-plane-4: SUCCESS (0.443s) [511.926581] Starting dynamic subtest: pipe-B-plane-5 [511.936980] Dynamic subtest pipe-B-plane-5: SUCCESS (0.021s) [511.937921] Subtest plane-position-hole-dpms: SUCCESS (4.451s) [512.118394] [115/133] (521s left) kms_pm_rpm (legacy-planes) [516.055467] Starting subtest: legacy-planes [516.057032] Starting dynamic subtest: plane-65 [523.153840] Dynamic subtest plane-65: SUCCESS (7.097s) [523.198562] Starting dynamic subtest: plane-95 [530.289438] Dynamic subtest plane-95: SUCCESS (7.132s) [530.329622] Starting dynamic subtest: plane-125 [537.511233] Dynamic subtest plane-125: SUCCESS (7.218s) [537.552305] Starting dynamic subtest: plane-135 [544.689464] Dynamic subtest plane-135: SUCCESS (7.175s) [544.693506] Subtest legacy-planes: SUCCESS (28.635s) [545.702980] [116/133] (488s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [547.226040] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [547.227853] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [547.439490] [117/133] (486s left) kms_color (deep-color) [548.955214] Starting subtest: deep-color [548.963497] Subtest deep-color: SKIP (0.003s) [549.164113] [118/133] (485s left) syncobj_eventfd (timeline-wait) [549.243401] Starting subtest: timeline-wait [549.254263] Subtest timeline-wait: SUCCESS (0.011s) [549.427523] [119/133] (485s left) kms_psr (fbc-psr2-sprite-render) [550.940552] Subtest fbc-psr2-sprite-render: SKIP (0.000s) [550.999403] [120/133] (483s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [552.516191] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [552.518072] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [552.673296] [121/133] (481s left) perf_pmu (busy-idle-no-semaphores) [552.775430] Starting subtest: busy-idle-no-semaphores [552.776391] Starting dynamic subtest: rcs0 [553.457408] Dynamic subtest rcs0: SUCCESS (0.681s) [553.475196] Starting dynamic subtest: bcs0 [554.111349] Dynamic subtest bcs0: SUCCESS (0.650s) [554.129169] Starting dynamic subtest: vcs0 [554.765728] Dynamic subtest vcs0: SUCCESS (0.651s) [554.784144] Starting dynamic subtest: vcs1 [555.419056] Dynamic subtest vcs1: SUCCESS (0.650s) [555.437639] Starting dynamic subtest: vecs0 [556.073769] Dynamic subtest vecs0: SUCCESS (0.651s) [556.091865] Starting dynamic subtest: vecs1 [556.729905] Dynamic subtest vecs1: SUCCESS (0.652s) [556.747888] Starting dynamic subtest: ccs0 [557.385549] Dynamic subtest ccs0: SUCCESS (0.652s) [557.387482] Subtest busy-idle-no-semaphores: SUCCESS (4.611s) [557.587389] [122/133] (477s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [559.105137] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [559.106923] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [559.269963] [123/133] (475s left) kms_big_fb (4-tiled-16bpp-rotate-270) [560.813039] Starting subtest: 4-tiled-16bpp-rotate-270 [560.872676] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.060s) [561.053522] [124/133] (473s left) kms_flip (2x-absolute-wf_vblank) [562.565945] Starting subtest: 2x-absolute-wf_vblank [562.578362] Subtest 2x-absolute-wf_vblank: SKIP (0.013s) [562.678358] [125/133] (472s left) core_setmaster (master-drop-set-root) [562.797032] Starting subtest: master-drop-set-root [562.821659] Subtest master-drop-set-root: SUCCESS (0.025s) [562.903744] [126/133] (472s left) gem_ctx_param (invalid-param-set) [562.984733] Starting subtest: invalid-param-set [562.985577] Subtest invalid-param-set: SUCCESS (0.000s) [563.088258] [127/133] (471s left) kms_sequence (get-idle) [564.601155] Starting subtest: get-idle [564.602066] Starting dynamic subtest: pipe-A-HDMI-A-3 [566.961670] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.359s) [566.972953] Starting dynamic subtest: pipe-B-HDMI-A-3 [569.186428] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.224s) [569.198579] Starting dynamic subtest: pipe-C-HDMI-A-3 [571.401447] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.213s) [571.414133] Starting dynamic subtest: pipe-D-HDMI-A-3 [573.619228] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.216s) [573.620163] Subtest get-idle: SUCCESS (9.019s) [573.823831] [128/133] (461s left) gem_mmap_wc (invalid-flags) [573.905346] Subtest invalid-flags: SKIP (0.000s) [573.974145] [129/133] (461s left) kms_chamelium_frames (vga-frame-dump) [575.537436] Subtest vga-frame-dump: SKIP (0.000s) [575.638708] [130/133] (459s left) kms_flip (2x-flip-vs-dpms-on-nop) [577.157264] Starting subtest: 2x-flip-vs-dpms-on-nop [577.170907] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.013s) [577.277030] [131/133] (457s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [578.809098] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [578.810856] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [578.936879] [132/133] (456s left) gem_userptr_blits (unsync-unmap-cycles) [579.051890] Subtest unsync-unmap-cycles: SKIP (0.000s) [579.225565] [133/133] (456s left) fbdev (eof) [579.286402] Starting subtest: eof [579.287353] Subtest eof: SUCCESS (0.000s) [579.394681] Closing watchdogs results: parsing output: 0/ for test: gem_render_copy results: parsing output: 1/ for test: kms_flip results: parsing output: 2/ for test: kms_content_protection results: parsing output: 3/ for test: gem_close_race results: parsing output: 4/ for test: tools_test results: parsing output: 5/ for test: gem_mmap_gtt results: parsing output: 6/ for test: syncobj_timeline results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: prime_mmap results: parsing output: 9/ for test: gem_ctx_shared results: parsing output: 10/ for test: kms_ccs results: parsing output: 11/ for test: gem_exec_fence results: parsing output: 12/ for test: syncobj_timeline results: parsing output: 13/ for test: kms_psr results: parsing output: 14/ for test: api_intel_bb results: parsing output: 15/ for test: gem_spin_batch results: parsing output: 16/ for test: vgem_basic results: parsing output: 17/ for test: syncobj_timeline results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_big_fb results: parsing output: 20/ for test: kms_pm_rpm results: parsing output: 21/ for test: kms_invalid_mode results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_cursor_edge_walk results: parsing output: 24/ for test: syncobj_wait results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_cursor_legacy results: parsing output: 27/ for test: kms_flip results: parsing output: 28/ for test: i915_query results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: kms_atomic_transition results: parsing output: 32/ for test: kms_flip results: parsing output: 33/ for test: gem_create results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_ccs results: parsing output: 36/ for test: kms_chamelium_color results: parsing output: 37/ for test: kms_flip results: parsing output: 38/ for test: kms_flip_scaled_crc results: parsing output: 39/ for test: kms_ccs results: parsing output: 40/ for test: gem_softpin results: parsing output: 41/ for test: i915_hangman results: parsing output: 42/ for test: kms_psr results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: kms_lease results: parsing output: 45/ for test: kms_psr2_sf results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: syncobj_timeline results: parsing output: 48/ for test: gem_userptr_blits results: parsing output: 49/ for test: kms_getfb results: parsing output: 50/ for test: kms_cursor_crc results: parsing output: 51/ for test: gem_wait results: parsing output: 52/ for test: sw_sync results: parsing output: 53/ for test: kms_async_flips results: parsing output: 54/ for test: gem_pread results: parsing output: 55/ for test: kms_rotation_crc results: parsing output: 56/ for test: kms_plane results: parsing output: 57/ for test: kms_cursor_legacy results: parsing output: 58/ for test: syncobj_wait results: parsing output: 59/ for test: kms_psr results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: kms_vblank results: parsing output: 64/ for test: kms_cursor_legacy results: parsing output: 65/ for test: kms_big_fb results: parsing output: 66/ for test: gem_lmem_swapping results: parsing output: 67/ for test: prime_vgem results: parsing output: 68/ for test: vgem_basic results: parsing output: 69/ for test: gem_exec_whisper results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: gem_exec_schedule results: parsing output: 72/ for test: kms_plane_scaling results: parsing output: 73/ for test: gem_exec_params results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: gem_ctx_persistence results: parsing output: 77/ for test: kms_plane_cursor results: parsing output: 78/ for test: gem_exec_fence results: parsing output: 79/ for test: gem_mmap_gtt results: parsing output: 80/ for test: gem_exec_parallel results: parsing output: 81/ for test: gem_pxp results: parsing output: 82/ for test: kms_cursor_crc results: parsing output: 83/ for test: kms_psr2_sf results: parsing output: 84/ for test: gem_mmap_gtt results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: kms_big_fb results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: gem_mmap_offset results: parsing output: 89/ for test: gem_fence_thrash results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_plane_alpha_blend results: parsing output: 94/ for test: kms_chamelium_frames results: parsing output: 95/ for test: kms_addfb_basic results: parsing output: 96/ for test: gem_wait results: parsing output: 97/ for test: i915_drm_fdinfo results: parsing output: 98/ for test: perf_pmu results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: syncobj_wait results: parsing output: 101/ for test: gem_ctx_persistence results: parsing output: 102/ for test: gen9_exec_parse results: parsing output: 103/ for test: vgem_basic results: parsing output: 104/ for test: kms_draw_crc results: parsing output: 105/ for test: gem_exec_balancer results: parsing output: 106/ for test: api_intel_allocator results: parsing output: 107/ for test: kms_cursor_legacy results: parsing output: 108/ for test: gem_exec_params results: parsing output: 109/ for test: prime_mmap results: parsing output: 110/ for test: kms_flip results: parsing output: 111/ for test: kms_busy results: parsing output: 112/ for test: i915_pm_rps results: parsing output: 113/ for test: kms_plane results: parsing output: 114/ for test: kms_pm_rpm results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_color results: parsing output: 117/ for test: syncobj_eventfd results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: perf_pmu results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: kms_flip results: parsing output: 124/ for test: core_setmaster results: parsing output: 125/ for test: gem_ctx_param results: parsing output: 126/ for test: kms_sequence results: parsing output: 127/ for test: gem_mmap_wc results: parsing output: 128/ for test: kms_chamelium_frames results: parsing output: 129/ for test: kms_flip results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: gem_userptr_blits results: parsing output: 132/ for test: fbdev Done.