[65.502523] Initializing watchdogs [65.502590] /dev/watchdog0 [65.522774] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [65.533971] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [65.537645] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [65.539941] [001/133] (960s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [65.621704] Starting subtest: y-tiled-to-vebox-yf-tiled [65.623436] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [65.841181] [002/133] (960s left) kms_flip (nonexisting-fb-interruptible) [67.360817] Starting subtest: nonexisting-fb-interruptible [67.366943] Starting dynamic subtest: A-HDMI-A3 [67.656707] Dynamic subtest A-HDMI-A3: SUCCESS (0.290s) [67.665059] Starting dynamic subtest: B-HDMI-A3 [67.841596] Dynamic subtest B-HDMI-A3: SUCCESS (0.184s) [67.848993] Starting dynamic subtest: C-HDMI-A3 [68.010295] Dynamic subtest C-HDMI-A3: SUCCESS (0.168s) [68.017733] Starting dynamic subtest: D-HDMI-A3 [68.179455] Dynamic subtest D-HDMI-A3: SUCCESS (0.168s) [68.180446] Subtest nonexisting-fb-interruptible: SUCCESS (0.818s) [68.406934] [003/133] (957s left) kms_content_protection (uevent-hdcp14) [69.987940] Starting subtest: uevent-hdcp14 [69.990855] Subtest uevent-hdcp14: SKIP (0.002s) [70.160495] [004/133] (956s left) gem_close_race (multigpu-basic-threads) [70.277093] Starting subtest: multigpu-basic-threads [70.278996] Subtest multigpu-basic-threads: SKIP (0.000s) [70.559427] [005/133] (955s left) tools_test (tools_test) [70.608992] Starting subtest: tools_test [70.684618] Subtest tools_test: SUCCESS (0.081s) [70.749575] [006/133] (955s left) gem_mmap_gtt (bad-object) [70.819973] Subtest bad-object: SKIP (0.000s) [70.880358] [007/133] (955s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [70.955325] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [70.956262] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s) [71.110823] [008/133] (955s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [72.625486] Starting subtest: fbc-indfb-scaledprimary [74.166994] Subtest fbc-indfb-scaledprimary: SUCCESS (1.533s) [74.327818] [009/133] (952s left) prime_mmap (test_refcounting) [74.399903] Starting subtest: test_refcounting [74.400860] Starting dynamic subtest: test_refcounting-smem [74.449964] Dynamic subtest test_refcounting-smem: SUCCESS (0.050s) [74.457499] Starting dynamic subtest: test_refcounting-lmem0 [74.651416] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.201s) [74.652375] Subtest test_refcounting: SUCCESS (0.251s) [74.805492] [010/133] (951s left) gem_ctx_shared (q-in-order) [74.888975] Starting subtest: Q-in-order [74.889954] Starting dynamic subtest: rcs0 [75.184375] Dynamic subtest rcs0: SUCCESS (0.295s) [75.192600] Starting dynamic subtest: bcs0 [75.364252] Dynamic subtest bcs0: SUCCESS (0.179s) [75.372858] Starting dynamic subtest: vcs0 [75.554652] Dynamic subtest vcs0: SUCCESS (0.190s) [75.563576] Starting dynamic subtest: vcs1 [75.755260] Dynamic subtest vcs1: SUCCESS (0.190s) [75.763206] Starting dynamic subtest: vecs0 [75.934753] Dynamic subtest vecs0: SUCCESS (0.189s) [75.943246] Starting dynamic subtest: vecs1 [76.124500] Dynamic subtest vecs1: SUCCESS (0.189s) [76.132865] Starting dynamic subtest: ccs0 [76.313224] Dynamic subtest ccs0: SUCCESS (0.188s) [76.314177] Subtest Q-in-order: SUCCESS (1.424s) [76.645720] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true [76.647624] [011/133] (949s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [78.161968] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [78.162866] Starting dynamic subtest: pipe-A-HDMI-A-3 [78.171202] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [78.179478] Starting dynamic subtest: pipe-B-HDMI-A-3 [78.187950] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [78.195820] Starting dynamic subtest: pipe-C-HDMI-A-3 [78.204122] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [78.211685] Starting dynamic subtest: pipe-D-HDMI-A-3 [78.222852] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [78.224596] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s) [78.497959] [012/133] (948s left) gem_exec_fence (submit-chain) [78.710540] Starting subtest: submit-chain [78.775087] Subtest submit-chain: SUCCESS (0.066s) [79.442530] [013/133] (947s left) syncobj_timeline (transfer-timeline-point) [79.518941] Starting subtest: transfer-timeline-point [79.519906] Subtest transfer-timeline-point: SUCCESS (0.000s) [79.698347] [014/133] (947s left) kms_psr (psr-primary-mmap-cpu) [81.211102] Subtest psr-primary-mmap-cpu: SKIP (0.000s) [81.268514] [015/133] (945s left) api_intel_bb (render) [81.348203] Starting subtest: render [81.349141] Starting dynamic subtest: render-none-512 [81.397456] Dynamic subtest render-none-512: SUCCESS (0.049s) [81.405352] Starting dynamic subtest: render-none-1024 [81.469375] Dynamic subtest render-none-1024: SUCCESS (0.072s) [81.477675] Starting dynamic subtest: render-x-512 [81.487806] Dynamic subtest render-x-512: SUCCESS (0.018s) [81.496133] Starting dynamic subtest: render-x-1024 [81.555610] Dynamic subtest render-x-1024: SUCCESS (0.068s) [81.563736] Starting dynamic subtest: render-y-512 [81.574359] Dynamic subtest render-y-512: SUCCESS (0.019s) [81.582521] Starting dynamic subtest: render-y-1024 [81.637165] Dynamic subtest render-y-1024: SUCCESS (0.062s) [81.638191] Subtest render: SUCCESS (0.289s) [81.794537] [016/133] (945s left) gem_spin_batch (legacy-resubmit-new) [81.885249] Starting subtest: legacy-resubmit-new [81.886211] Starting dynamic subtest: default [81.919585] Dynamic subtest default: SUCCESS (0.034s) [81.928051] Starting dynamic subtest: render [81.928960] Dynamic subtest render: SUCCESS (0.004s) [81.937395] Starting dynamic subtest: bsd [81.938340] Dynamic subtest bsd: SUCCESS (0.007s) [81.946717] Starting dynamic subtest: bsd1 [81.947530] Dynamic subtest bsd1: SUCCESS (0.006s) [81.956244] Starting dynamic subtest: bsd2 [81.957192] Dynamic subtest bsd2: SUCCESS (0.004s) [81.965305] Starting dynamic subtest: blt [81.966473] Dynamic subtest blt: SUCCESS (0.005s) [81.974492] Starting dynamic subtest: vebox [81.975477] Dynamic subtest vebox: SUCCESS (0.005s) [81.976493] Subtest legacy-resubmit-new: SUCCESS (0.067s) [82.250499] [017/133] (944s left) vgem_basic (dmabuf-fence-before) [82.311286] Starting subtest: dmabuf-fence-before [82.312183] Subtest dmabuf-fence-before: SUCCESS (0.000s) [82.432944] [018/133] (944s left) syncobj_timeline (etime-single-wait-all-submitted) [82.514065] Starting subtest: etime-single-wait-all-submitted [82.615577] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s) [82.752257] [019/133] (944s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt) [84.271813] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt [84.273905] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [84.431529] [020/133] (942s left) kms_big_fb (x-tiled-64bpp-rotate-0) [85.990228] Starting subtest: x-tiled-64bpp-rotate-0 [87.861866] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.871s) [88.032582] [021/133] (939s left) kms_pm_rpm (dpms-mode-unset-lpsp) [92.102065] Starting subtest: dpms-mode-unset-lpsp [93.108595] Subtest dpms-mode-unset-lpsp: SKIP (1.007s) [94.113216] [022/133] (933s left) kms_invalid_mode (bad-vsync-end) [95.629894] Starting subtest: bad-vsync-end [95.630826] Starting dynamic subtest: pipe-A-HDMI-A-3 [95.674161] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.044s) [95.682895] Starting dynamic subtest: pipe-B-HDMI-A-3 [95.684084] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.001s) [95.692564] Starting dynamic subtest: pipe-C-HDMI-A-3 [95.693593] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.001s) [95.701909] Starting dynamic subtest: pipe-D-HDMI-A-3 [95.702863] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.001s) [95.703748] Subtest bad-vsync-end: SUCCESS (0.050s) [95.852794] [023/133] (931s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [97.372794] Starting subtest: fbcpsr-farfromfence-mmap-gtt [97.374422] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [97.531633] [024/133] (930s left) kms_cursor_edge_walk (128x128-right-edge) [99.075971] Starting subtest: 128x128-right-edge [99.076914] Starting dynamic subtest: pipe-A-HDMI-A-3 [102.408902] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.331s) [102.417560] Starting dynamic subtest: pipe-D-HDMI-A-3 [105.641212] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.231s) [105.642160] Subtest 128x128-right-edge: SUCCESS (6.565s) [105.823557] [025/133] (921s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [105.905259] Starting subtest: multi-wait-for-submit-unsubmitted [106.007641] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.102s) [106.108168] [026/133] (921s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [107.629964] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [107.631722] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s) [107.779848] [027/133] (919s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [109.328210] Starting subtest: short-flip-after-cursor-toggle [110.321373] Subtest short-flip-after-cursor-toggle: SUCCESS (0.993s) [110.494602] [028/133] (917s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [112.007146] Starting subtest: 2x-flip-vs-blocking-wf-vblank [112.020203] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.013s) [112.174337] [029/133] (915s left) i915_query (query-regions-unallocated) [112.282975] Starting subtest: query-regions-unallocated [113.370561] Subtest query-regions-unallocated: SUCCESS (1.088s) [113.462782] [030/133] (914s left) kms_big_fb (4-tiled-16bpp-rotate-180) [114.985118] Starting subtest: 4-tiled-16bpp-rotate-180 [116.781511] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.796s) [116.968641] [031/133] (911s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [118.481981] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [118.482927] Starting dynamic subtest: pipe-A-HDMI-A-3 [118.491161] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [118.499891] Starting dynamic subtest: pipe-B-HDMI-A-3 [118.508531] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [118.517124] Starting dynamic subtest: pipe-C-HDMI-A-3 [118.525233] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [118.533535] Starting dynamic subtest: pipe-D-HDMI-A-3 [118.543370] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [118.545447] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s) [118.751813] [032/133] (909s left) kms_atomic_transition (plane-all-modeset-transition) [120.269442] Starting subtest: plane-all-modeset-transition [120.270405] Starting dynamic subtest: pipe-A-HDMI-A-3 [131.427882] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (11.157s) [131.477434] Starting dynamic subtest: pipe-B-HDMI-A-3 [139.218864] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (7.752s) [139.236422] Subtest plane-all-modeset-transition: SUCCESS (18.966s) [139.408948] [033/133] (888s left) kms_flip (2x-nonexisting-fb-interruptible) [140.926413] Starting subtest: 2x-nonexisting-fb-interruptible [140.940251] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.013s) [141.031588] [034/133] (887s left) gem_create (create-valid-nonaligned) [141.123016] Starting subtest: create-valid-nonaligned [141.123972] Subtest create-valid-nonaligned: SUCCESS (0.000s) [141.367667] [035/133] (886s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [142.884280] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [142.886068] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [143.023743] [036/133] (885s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs) [144.567154] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs [144.568051] Starting dynamic subtest: pipe-A-HDMI-A-3 [144.576267] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [144.584744] Starting dynamic subtest: pipe-B-HDMI-A-3 [144.593154] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [144.601470] Starting dynamic subtest: pipe-C-HDMI-A-3 [144.609593] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [144.617771] Starting dynamic subtest: pipe-D-HDMI-A-3 [144.627664] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [144.629498] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s) [144.833568] [037/133] (883s left) kms_chamelium_color (ctm-0-25) [146.348269] Subtest ctm-0-25: SKIP (0.000s) [146.404283] [038/133] (882s left) kms_flip (basic-flip-vs-wf_vblank) [147.920062] Starting subtest: basic-flip-vs-wf_vblank [147.925348] Starting dynamic subtest: A-HDMI-A3 [148.967449] Dynamic subtest A-HDMI-A3: SUCCESS (1.042s) [148.977532] Starting dynamic subtest: B-HDMI-A3 [149.935794] Dynamic subtest B-HDMI-A3: SUCCESS (0.967s) [149.945505] Starting dynamic subtest: C-HDMI-A3 [150.904188] Dynamic subtest C-HDMI-A3: SUCCESS (0.968s) [150.913307] Starting dynamic subtest: D-HDMI-A3 [152.038173] Dynamic subtest D-HDMI-A3: SUCCESS (1.133s) [152.039160] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.119s) [152.249252] [039/133] (876s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [153.762522] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [153.764263] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [153.871659] [040/133] (874s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [155.401376] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [155.402256] Starting dynamic subtest: pipe-A-HDMI-A-3 [155.423268] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s) [155.432038] Starting dynamic subtest: pipe-B-HDMI-A-3 [155.454159] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s) [155.462683] Starting dynamic subtest: pipe-C-HDMI-A-3 [155.487081] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s) [155.495476] Starting dynamic subtest: pipe-D-HDMI-A-3 [155.517151] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s) [155.518827] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.013s) [155.666025] [041/133] (873s left) gem_softpin (evict-active-interruptible) [155.754389] Starting subtest: evict-active-interruptible [155.773183] Subtest evict-active-interruptible: SUCCESS (0.019s) [155.927690] [042/133] (872s left) i915_hangman (error-state-basic) [156.027012] Starting subtest: error-state-basic [156.242070] Subtest error-state-basic: SUCCESS (0.215s) [156.365111] [043/133] (872s left) kms_psr (fbc-psr2-primary-page-flip) [157.882074] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s) [157.938426] [044/133] (870s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [159.466431] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [159.468229] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [159.604364] [045/133] (869s left) kms_lease (master-vs-lease) [161.138406] Starting subtest: master-vs-lease [161.140336] Subtest master-vs-lease: SUCCESS (0.002s) [161.301247] [046/133] (867s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [162.842375] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s) [162.905583] [047/133] (866s left) kms_psr (fbc-pr-cursor-plane-move) [164.421242] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [164.472029] [048/133] (864s left) syncobj_timeline (invalid-single-wait-unsubmitted) [164.561111] Starting subtest: invalid-single-wait-unsubmitted [164.562059] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [164.715312] [049/133] (864s left) gem_userptr_blits (input-checking) [164.803100] Starting subtest: input-checking [164.803963] Subtest input-checking: SUCCESS (0.000s) [164.978827] [050/133] (864s left) kms_getfb (getfb2-into-addfb2) [166.494259] Starting subtest: getfb2-into-addfb2 [166.495168] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [166.660222] [051/133] (862s left) kms_cursor_crc (cursor-offscreen-64x21) [168.379922] Starting subtest: cursor-offscreen-64x21 [168.383807] Starting dynamic subtest: pipe-A-HDMI-A-3 [170.854969] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.471s) [170.894784] Starting dynamic subtest: pipe-D-HDMI-A-3 [173.255180] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.368s) [173.256114] Subtest cursor-offscreen-64x21: SUCCESS (4.875s) [173.608648] [052/133] (855s left) gem_wait (write-busy) [173.705141] Starting subtest: write-busy [173.705998] Starting dynamic subtest: all-engines [174.307578] Dynamic subtest all-engines: SUCCESS (0.603s) [174.317202] Starting dynamic subtest: rcs0 [174.856171] Dynamic subtest rcs0: SUCCESS (0.548s) [174.866067] Starting dynamic subtest: bcs0 [175.401508] Dynamic subtest bcs0: SUCCESS (0.545s) [175.411231] Starting dynamic subtest: vcs0 [175.944062] Dynamic subtest vcs0: SUCCESS (0.542s) [175.953712] Starting dynamic subtest: vcs1 [176.485992] Dynamic subtest vcs1: SUCCESS (0.541s) [176.495491] Starting dynamic subtest: vecs0 [177.028097] Dynamic subtest vecs0: SUCCESS (0.542s) [177.037550] Starting dynamic subtest: vecs1 [177.569037] Dynamic subtest vecs1: SUCCESS (0.540s) [177.578508] Starting dynamic subtest: ccs0 [178.111189] Dynamic subtest ccs0: SUCCESS (0.542s) [178.112011] Subtest write-busy: SUCCESS (4.407s) [178.362106] [053/133] (851s left) sw_sync (sync_random_merge) [178.420207] Starting subtest: sync_random_merge [178.484572] Subtest sync_random_merge: SUCCESS (0.072s) [178.564578] [054/133] (850s left) kms_async_flips (crc) [180.076424] Starting subtest: crc [180.297476] Starting dynamic subtest: pipe-A-HDMI-A-3 [182.683060] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.386s) [182.851239] Starting dynamic subtest: pipe-B-HDMI-A-3 [185.040729] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.198s) [185.188190] Starting dynamic subtest: pipe-C-HDMI-A-3 [187.375291] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.195s) [187.518204] Starting dynamic subtest: pipe-D-HDMI-A-3 [189.680230] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.171s) [189.681176] Subtest crc: SUCCESS (9.604s) [190.003306] [055/133] (839s left) gem_pread (exhaustion) [190.082055] Subtest exhaustion: SKIP (0.000s) [190.150130] [056/133] (839s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [191.662554] Starting subtest: primary-yf-tiled-reflect-x-180 [191.757383] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.095s) [191.934776] [057/133] (837s left) kms_plane (pixel-format-yf-tiled-ccs-modifier) [193.448512] Starting subtest: pixel-format-yf-tiled-ccs-modifier [193.450268] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s) [193.540887] [058/133] (836s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [195.074511] Starting subtest: basic-flip-before-cursor-atomic [196.063470] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.989s) [196.257292] [059/133] (833s left) syncobj_wait (invalid-reset-one-illegal-handle) [196.339396] Starting subtest: invalid-reset-one-illegal-handle [196.340332] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [196.480623] [060/133] (833s left) kms_psr (psr2-primary-mmap-gtt) [197.998431] Subtest psr2-primary-mmap-gtt: SKIP (0.000s) [198.060362] [061/133] (831s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [199.579733] Starting subtest: fbcpsr-slowdraw [199.581414] Subtest fbcpsr-slowdraw: SKIP (0.000s) [199.776527] [062/133] (830s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [201.305425] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [201.307122] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [201.439903] [063/133] (828s left) kms_psr (pr-dpms) [202.982139] Subtest pr-dpms: SKIP (0.000s) [203.045118] [064/133] (827s left) kms_vblank (wait-forked-hang) [204.560687] Starting subtest: wait-forked-hang [204.561538] Starting dynamic subtest: pipe-A-HDMI-A-3 [231.525536] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.964s) [231.537462] Starting dynamic subtest: pipe-D-HDMI-A-3 [256.533639] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (25.003s) [256.534500] Subtest wait-forked-hang: SUCCESS (51.973s) [256.672125] [065/133] (773s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [258.185561] Starting subtest: cursorB-vs-flipB-atomic-transitions [258.187274] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [258.273984] [066/133] (772s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [259.817075] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [260.907450] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.090s) [261.096222] [067/133] (769s left) gem_lmem_swapping (heavy-verify-multi) [265.517981] Starting subtest: heavy-verify-multi [265.518951] Starting dynamic subtest: lmem0 [278.502046] Dynamic subtest lmem0: SUCCESS (12.984s) [278.503105] Subtest heavy-verify-multi: SUCCESS (12.985s) [279.618147] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [279.619152] [FACT gem_lmem_swapping (heavy-verify-multi)] deleted: kernel.kmod_is_loaded.i915: true [279.620942] [068/133] (750s left) prime_vgem (wait) [283.153253] Starting subtest: wait [283.154634] Starting dynamic subtest: rcs0 [283.219601] Dynamic subtest rcs0: SUCCESS (0.066s) [283.230148] Starting dynamic subtest: bcs0 [283.269806] Dynamic subtest bcs0: SUCCESS (0.049s) [283.281162] Starting dynamic subtest: vcs0 [283.314882] Dynamic subtest vcs0: SUCCESS (0.044s) [283.339766] Starting dynamic subtest: vcs1 [283.361792] Dynamic subtest vcs1: SUCCESS (0.045s) [283.386974] Starting dynamic subtest: vecs0 [283.406412] Dynamic subtest vecs0: SUCCESS (0.043s) [283.424339] Starting dynamic subtest: vecs1 [283.449711] Dynamic subtest vecs1: SUCCESS (0.042s) [283.464784] Starting dynamic subtest: ccs0 [283.492048] Dynamic subtest ccs0: SUCCESS (0.041s) [283.493155] Subtest wait: SUCCESS (0.339s) [283.616940] [FACT prime_vgem (wait)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [283.619548] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.i915: true [283.621981] [069/133] (746s left) vgem_basic (unload) [283.670656] Starting subtest: unload [312.648050] Subtest unload: SUCCESS (28.975s) [312.770828] [070/133] (717s left) gem_exec_whisper (basic-fds-priority) [312.862394] Starting subtest: basic-fds-priority [335.662199] Subtest basic-fds-priority: SUCCESS (22.798s) [335.883630] [071/133] (694s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [337.410829] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [337.412473] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [337.561411] [072/133] (693s left) gem_exec_schedule (noreorder) [337.808949] Starting subtest: noreorder [337.809944] Starting dynamic subtest: rcs0 [337.894264] Dynamic subtest rcs0: SUCCESS (0.085s) [337.903966] Starting dynamic subtest: bcs0 [337.942301] Dynamic subtest bcs0: SUCCESS (0.047s) [337.954697] Starting dynamic subtest: vcs0 [337.992246] Dynamic subtest vcs0: SUCCESS (0.049s) [338.003527] Starting dynamic subtest: vcs1 [338.045569] Dynamic subtest vcs1: SUCCESS (0.052s) [338.064415] Starting dynamic subtest: vecs0 [338.102505] Dynamic subtest vecs0: SUCCESS (0.056s) [338.124274] Starting dynamic subtest: vecs1 [338.184415] Dynamic subtest vecs1: SUCCESS (0.080s) [338.205206] Starting dynamic subtest: ccs0 [338.216518] Dynamic subtest ccs0: SUCCESS (0.031s) [338.217479] Subtest noreorder: SUCCESS (0.408s) [338.524644] [073/133] (692s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75) [340.038600] Starting subtest: planes-unity-scaling-downscale-factor-0-75 [340.039468] Starting dynamic subtest: pipe-A [340.140175] Dynamic subtest pipe-A: SUCCESS (0.103s) [340.150579] Starting dynamic subtest: pipe-B [340.284979] Dynamic subtest pipe-B: SUCCESS (0.144s) [340.297876] Starting dynamic subtest: pipe-C [340.427191] Dynamic subtest pipe-C: SUCCESS (0.141s) [340.436639] Starting dynamic subtest: pipe-D [340.552930] Dynamic subtest pipe-D: SUCCESS (0.125s) [340.553925] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.516s) [340.753779] [074/133] (690s left) gem_exec_params (invalid-bsd-ring) [340.837494] Starting subtest: invalid-bsd-ring [340.838388] Subtest invalid-bsd-ring: SUCCESS (0.000s) [340.971576] [075/133] (689s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [342.491510] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [342.493205] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [342.657779] [076/133] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [344.200711] Starting subtest: fbcpsr-2p-rte [344.202323] Subtest fbcpsr-2p-rte: SKIP (0.000s) [344.346158] [077/133] (686s left) gem_ctx_persistence (legacy-engines-persistence) [344.483479] Starting subtest: legacy-engines-persistence [344.484392] Starting dynamic subtest: render [345.346584] Dynamic subtest render: SUCCESS (0.862s) [345.357699] Starting dynamic subtest: bsd1 [346.108220] Dynamic subtest bsd1: SUCCESS (0.760s) [346.120724] Starting dynamic subtest: bsd2 [346.877089] Dynamic subtest bsd2: SUCCESS (0.765s) [346.889670] Starting dynamic subtest: blt [347.640241] Dynamic subtest blt: SUCCESS (0.760s) [347.652509] Starting dynamic subtest: vebox [348.408172] Dynamic subtest vebox: SUCCESS (0.764s) [348.409733] Subtest legacy-engines-persistence: SUCCESS (3.926s) [348.574108] [078/133] (682s left) kms_plane_cursor (viewport) [350.089683] Starting subtest: viewport [350.091434] Starting dynamic subtest: pipe-A-HDMI-A-3-size-64 [353.362448] Dynamic subtest pipe-A-HDMI-A-3-size-64: SUCCESS (3.272s) [353.444204] Starting dynamic subtest: pipe-A-HDMI-A-3-size-128 [356.662982] Dynamic subtest pipe-A-HDMI-A-3-size-128: SUCCESS (3.233s) [356.758715] Starting dynamic subtest: pipe-A-HDMI-A-3-size-256 [360.012950] Dynamic subtest pipe-A-HDMI-A-3-size-256: SUCCESS (3.282s) [360.147987] Starting dynamic subtest: pipe-B-HDMI-A-3-size-64 [363.403875] Dynamic subtest pipe-B-HDMI-A-3-size-64: SUCCESS (3.264s) [363.462818] Starting dynamic subtest: pipe-B-HDMI-A-3-size-128 [366.687309] Dynamic subtest pipe-B-HDMI-A-3-size-128: SUCCESS (3.234s) [366.745576] Starting dynamic subtest: pipe-B-HDMI-A-3-size-256 [370.020133] Dynamic subtest pipe-B-HDMI-A-3-size-256: SUCCESS (3.283s) [370.130804] Starting dynamic subtest: pipe-C-HDMI-A-3-size-64 [373.419827] Dynamic subtest pipe-C-HDMI-A-3-size-64: SUCCESS (3.301s) [373.478574] Starting dynamic subtest: pipe-C-HDMI-A-3-size-128 [376.619861] Dynamic subtest pipe-C-HDMI-A-3-size-128: SUCCESS (3.150s) [376.687051] Starting dynamic subtest: pipe-C-HDMI-A-3-size-256 [379.936811] Dynamic subtest pipe-C-HDMI-A-3-size-256: SUCCESS (3.266s) [380.038236] Starting dynamic subtest: pipe-D-HDMI-A-3-size-64 [383.407102] Dynamic subtest pipe-D-HDMI-A-3-size-64: SUCCESS (3.377s) [383.465378] Starting dynamic subtest: pipe-D-HDMI-A-3-size-128 [386.773909] Dynamic subtest pipe-D-HDMI-A-3-size-128: SUCCESS (3.317s) [386.833147] Starting dynamic subtest: pipe-D-HDMI-A-3-size-256 [390.124170] Dynamic subtest pipe-D-HDMI-A-3-size-256: SUCCESS (3.300s) [390.200333] Subtest viewport: SUCCESS (40.110s) [390.393341] [079/133] (640s left) gem_exec_fence (concurrent) [390.604801] Starting subtest: concurrent [390.607082] Subtest concurrent: SKIP (0.000s) [391.373426] [080/133] (639s left) gem_mmap_gtt (medium-copy-odd) [391.454165] Subtest medium-copy-odd: SKIP (0.000s) [391.528025] [081/133] (639s left) gem_exec_parallel (userptr) [391.616581] Starting subtest: userptr [391.617482] Starting dynamic subtest: rcs0 [393.181520] Dynamic subtest rcs0: SUCCESS (1.564s) [393.192751] Starting dynamic subtest: bcs0 [394.733436] Dynamic subtest bcs0: SUCCESS (1.551s) [394.745289] Starting dynamic subtest: vcs0 [396.221674] Dynamic subtest vcs0: SUCCESS (1.487s) [396.233271] Starting dynamic subtest: vcs1 [397.708689] Dynamic subtest vcs1: SUCCESS (1.486s) [397.722147] Starting dynamic subtest: vecs0 [399.203564] Dynamic subtest vecs0: SUCCESS (1.493s) [399.216355] Starting dynamic subtest: vecs1 [400.701580] Dynamic subtest vecs1: SUCCESS (1.497s) [400.713166] Starting dynamic subtest: ccs0 [402.169286] Dynamic subtest ccs0: SUCCESS (1.466s) [402.170268] Subtest userptr: SUCCESS (10.553s) [402.439014] [082/133] (629s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [405.050384] Starting subtest: verify-pxp-execution-after-suspend-resume [405.052513] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s) [405.195213] [083/133] (626s left) kms_cursor_crc (cursor-random-512x512) [406.978754] Starting subtest: cursor-random-512x512 [406.980461] Subtest cursor-random-512x512: SKIP (0.001s) [407.205664] [084/133] (624s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [408.730308] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [408.778226] [085/133] (622s left) gem_mmap_gtt (hang) [408.859170] Subtest hang: SKIP (0.000s) [408.928395] [086/133] (622s left) gem_exec_schedule (u-semaphore-noskip) [409.023603] Starting subtest: u-semaphore-noskip [409.835375] Subtest u-semaphore-noskip: SUCCESS (0.811s) [410.213097] [087/133] (621s left) kms_big_fb (linear-16bpp-rotate-180) [411.738958] Starting subtest: linear-16bpp-rotate-180 [413.701691] Subtest linear-16bpp-rotate-180: SUCCESS (1.962s) [413.925932] [088/133] (617s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [415.444037] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [418.051637] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.608s) [418.257909] [089/133] (613s left) gem_mmap_offset (isolation) [418.338673] Starting subtest: isolation [418.347347] Subtest isolation: SUCCESS (0.007s) [418.451770] [090/133] (613s left) gem_fence_thrash (bo-write-verify-none) [418.501577] Starting subtest: bo-write-verify-none [418.530424] Subtest bo-write-verify-none: SKIP (0.029s) [418.623718] [091/133] (613s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [420.138987] Starting subtest: psr-rgb101010-draw-mmap-cpu [420.140767] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [420.271160] [092/133] (611s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [421.812973] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [424.951935] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.139s) [425.104279] [093/133] (607s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt) [426.622301] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt [426.624247] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [426.745263] [094/133] (605s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [428.279140] Starting subtest: coverage-vs-premult-vs-constant [428.527955] Starting dynamic subtest: pipe-A-HDMI-A-3 [428.925202] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.396s) [428.934693] Starting dynamic subtest: pipe-D-HDMI-A-3 [429.365186] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.439s) [429.368096] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.087s) [429.548875] [095/133] (602s left) kms_chamelium_frames (hdmi-crc-single) [431.114336] Subtest hdmi-crc-single: SKIP (0.000s) [431.216365] [096/133] (601s left) kms_addfb_basic (no-handle) [431.300514] Starting subtest: no-handle [431.301432] Subtest no-handle: SUCCESS (0.000s) [432.876372] [097/133] (599s left) gem_wait (invalid-buf) [432.991343] Starting subtest: invalid-buf [432.992267] Subtest invalid-buf: SUCCESS (0.000s) [433.271931] [098/133] (599s left) i915_drm_fdinfo (basics) [433.343471] Starting subtest: basics [433.344439] Subtest basics: SUCCESS (0.000s) [433.429347] [099/133] (599s left) perf_pmu (busy-double-start) [433.503517] Starting subtest: busy-double-start [433.504433] Starting dynamic subtest: rcs0 [437.099909] Dynamic subtest rcs0: SUCCESS (3.596s) [437.113734] Starting dynamic subtest: bcs0 [440.697177] Dynamic subtest bcs0: SUCCESS (3.593s) [440.710995] Starting dynamic subtest: vcs0 [444.310159] Dynamic subtest vcs0: FAIL (3.588s) [444.320160] Starting dynamic subtest: vcs1 [447.880032] Dynamic subtest vcs1: FAIL (3.565s) [447.895852] Starting dynamic subtest: vecs0 [451.444426] Dynamic subtest vecs0: FAIL (3.564s) [451.456456] Starting dynamic subtest: vecs1 [455.012273] Dynamic subtest vecs1: FAIL (3.565s) [455.024576] Starting dynamic subtest: ccs0 [458.576215] Dynamic subtest ccs0: SUCCESS (3.587s) [458.580421] Subtest busy-double-start: FAIL (25.075s) [458.699797] [100/133] (573s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [460.226369] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [460.228194] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [460.351575] [101/133] (572s left) syncobj_wait (invalid-multi-wait-unsubmitted) [460.453365] Starting subtest: invalid-multi-wait-unsubmitted [460.454277] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [460.606905] [102/133] (572s left) gem_ctx_persistence (engines-mixed) [460.696561] Starting subtest: engines-mixed [460.697493] Starting dynamic subtest: rcs0 [460.795451] Dynamic subtest rcs0: SUCCESS (0.098s) [460.807393] Starting dynamic subtest: bcs0 [460.843588] Dynamic subtest bcs0: SUCCESS (0.047s) [460.857279] Starting dynamic subtest: vcs0 [460.893381] Dynamic subtest vcs0: SUCCESS (0.048s) [460.911358] Starting dynamic subtest: vcs1 [460.947882] Dynamic subtest vcs1: SUCCESS (0.053s) [460.979944] Starting dynamic subtest: vecs0 [461.018033] Dynamic subtest vecs0: SUCCESS (0.067s) [461.050301] Starting dynamic subtest: vecs1 [461.095720] Dynamic subtest vecs1: SUCCESS (0.075s) [461.124593] Starting dynamic subtest: ccs0 [461.154285] Dynamic subtest ccs0: SUCCESS (0.056s) [461.155343] Subtest engines-mixed: SUCCESS (0.459s) [461.327845] [103/133] (571s left) gen9_exec_parse (basic-rejected) [461.413302] Subtest basic-rejected: SKIP (0.000s) [461.497413] [104/133] (571s left) vgem_basic (busy-fence) [461.552216] Starting subtest: busy-fence [461.553174] Subtest busy-fence: SUCCESS (0.000s) [461.645373] [105/133] (571s left) kms_draw_crc (draw-method-blt) [463.159491] Starting subtest: draw-method-blt [463.160401] Starting dynamic subtest: xrgb8888-untiled [463.534157] Dynamic subtest xrgb8888-untiled: SUCCESS (0.374s) [463.571719] Starting dynamic subtest: rgb565-untiled [463.867329] Dynamic subtest rgb565-untiled: SUCCESS (0.330s) [463.902915] Starting dynamic subtest: xrgb2101010-untiled [464.167411] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.296s) [464.185080] Starting dynamic subtest: xbgr16161616f-untiled [464.467484] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.296s) [464.504923] Starting dynamic subtest: xrgb8888-xtiled [464.634112] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.163s) [464.676219] Starting dynamic subtest: rgb565-xtiled [464.800898] Dynamic subtest rgb565-xtiled: SUCCESS (0.163s) [464.837084] Starting dynamic subtest: xrgb2101010-xtiled [464.950853] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.146s) [464.986888] Starting dynamic subtest: xbgr16161616f-xtiled [465.100821] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.146s) [465.136929] Starting dynamic subtest: xrgb8888-4tiled [465.267652] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.163s) [465.305018] Starting dynamic subtest: rgb565-4tiled [465.434417] Dynamic subtest rgb565-4tiled: SUCCESS (0.163s) [465.471655] Starting dynamic subtest: xrgb2101010-4tiled [465.584097] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.146s) [465.621801] Starting dynamic subtest: xbgr16161616f-4tiled [465.734107] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.146s) [465.739101] Subtest draw-method-blt: SUCCESS (2.577s) [465.924426] [106/133] (567s left) gem_exec_balancer (hog) [466.017407] Starting subtest: hog [466.019726] Subtest hog: SKIP (0.000s) [466.399619] [107/133] (566s left) api_intel_allocator (alloc-simple) [466.480228] Starting subtest: alloc-simple [466.505982] Subtest alloc-simple: SUCCESS (0.026s) [466.670261] [108/133] (566s left) kms_cursor_legacy (torture-bo) [468.185095] Starting subtest: torture-bo [468.185942] Starting dynamic subtest: pipe-A [473.670664] Dynamic subtest pipe-A: SUCCESS (5.479s) [473.693610] Starting dynamic subtest: pipe-B [479.112458] Dynamic subtest pipe-B: SUCCESS (5.446s) [479.122960] Starting dynamic subtest: pipe-C [484.579998] Dynamic subtest pipe-C: SUCCESS (5.466s) [484.590959] Starting dynamic subtest: pipe-D [490.118729] Dynamic subtest pipe-D: SUCCESS (5.537s) [490.132817] Starting dynamic subtest: all-pipes [495.673986] Dynamic subtest all-pipes: SUCCESS (5.553s) [495.675223] Subtest torture-bo: SUCCESS (27.489s) [495.826850] [109/133] (537s left) gem_exec_params (cliprects-invalid) [495.916462] Starting subtest: cliprects-invalid [495.917442] Subtest cliprects-invalid: SUCCESS (0.000s) [496.067862] [110/133] (537s left) prime_mmap (test_dup) [496.144888] Starting subtest: test_dup [496.145837] Starting dynamic subtest: test_dup-smem [496.193700] Dynamic subtest test_dup-smem: SUCCESS (0.048s) [496.205372] Starting dynamic subtest: test_dup-lmem0 [496.392714] Dynamic subtest test_dup-lmem0: SUCCESS (0.198s) [496.393665] Subtest test_dup: SUCCESS (0.248s) [496.483302] [111/133] (536s left) kms_flip (bo-too-big-interruptible) [498.004360] Starting subtest: bo-too-big-interruptible [498.010797] Starting dynamic subtest: A-HDMI-A3 [498.246269] Dynamic subtest A-HDMI-A3: SUCCESS (0.235s) [498.272645] Starting dynamic subtest: B-HDMI-A3 [498.396937] Dynamic subtest B-HDMI-A3: SUCCESS (0.148s) [498.409565] Starting dynamic subtest: C-HDMI-A3 [498.531462] Dynamic subtest C-HDMI-A3: SUCCESS (0.133s) [498.544638] Starting dynamic subtest: D-HDMI-A3 [498.666737] Dynamic subtest D-HDMI-A3: SUCCESS (0.134s) [498.668324] Subtest bo-too-big-interruptible: SUCCESS (0.663s) [498.894629] [112/133] (534s left) kms_busy (extended-pageflip-hang-oldfb) [500.417050] Starting subtest: extended-pageflip-hang-oldfb [500.419267] Starting dynamic subtest: pipe-A [500.618461] Dynamic subtest pipe-A: SUCCESS (0.199s) [500.637310] Starting dynamic subtest: pipe-D [500.791406] Dynamic subtest pipe-D: SUCCESS (0.168s) [500.793720] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.376s) [501.022405] [113/133] (532s left) i915_pm_rps (fence-order) [501.115246] Starting subtest: fence-order [505.418867] Subtest fence-order: SUCCESS (4.303s) [505.597923] [114/133] (527s left) kms_plane (plane-position-hole-dpms) [507.114235] Starting subtest: plane-position-hole-dpms [507.528403] Starting dynamic subtest: pipe-A-plane-1 [508.026185] Dynamic subtest pipe-A-plane-1: SUCCESS (0.498s) [508.036881] Starting dynamic subtest: pipe-A-plane-2 [508.509432] Dynamic subtest pipe-A-plane-2: SUCCESS (0.483s) [508.521769] Starting dynamic subtest: pipe-A-plane-3 [508.990161] Dynamic subtest pipe-A-plane-3: SUCCESS (0.479s) [509.001545] Starting dynamic subtest: pipe-A-plane-4 [509.487685] Dynamic subtest pipe-A-plane-4: SUCCESS (0.497s) [509.498658] Starting dynamic subtest: pipe-A-plane-5 [509.507271] Dynamic subtest pipe-A-plane-5: SUCCESS (0.017s) [509.779382] Starting dynamic subtest: pipe-B-plane-1 [510.214245] Dynamic subtest pipe-B-plane-1: SUCCESS (0.446s) [510.225377] Starting dynamic subtest: pipe-B-plane-2 [510.665137] Dynamic subtest pipe-B-plane-2: SUCCESS (0.450s) [510.676444] Starting dynamic subtest: pipe-B-plane-3 [511.114571] Dynamic subtest pipe-B-plane-3: SUCCESS (0.448s) [511.125499] Starting dynamic subtest: pipe-B-plane-4 [511.568401] Dynamic subtest pipe-B-plane-4: SUCCESS (0.453s) [511.579258] Starting dynamic subtest: pipe-B-plane-5 [511.589191] Dynamic subtest pipe-B-plane-5: SUCCESS (0.018s) [511.590275] Subtest plane-position-hole-dpms: SUCCESS (4.474s) [511.774086] [115/133] (521s left) kms_pm_rpm (legacy-planes) [516.035192] Starting subtest: legacy-planes [516.036382] Starting dynamic subtest: plane-65 [523.964524] Dynamic subtest plane-65: SUCCESS (7.930s) [524.002279] Starting dynamic subtest: plane-95 [531.057433] Dynamic subtest plane-95: SUCCESS (7.089s) [531.093390] Starting dynamic subtest: plane-125 [538.254225] Dynamic subtest plane-125: SUCCESS (7.194s) [538.285699] Starting dynamic subtest: plane-135 [545.380910] Dynamic subtest plane-135: SUCCESS (7.124s) [545.384910] Subtest legacy-planes: SUCCESS (29.349s) [546.407094] [116/133] (487s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [547.926309] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [547.928149] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [548.103475] [117/133] (485s left) kms_color (deep-color) [549.637138] Starting subtest: deep-color [549.645894] Subtest deep-color: SKIP (0.003s) [549.827677] [118/133] (484s left) syncobj_eventfd (timeline-wait) [549.919436] Starting subtest: timeline-wait [549.930120] Subtest timeline-wait: SUCCESS (0.011s) [550.037304] [119/133] (483s left) kms_psr (fbc-psr2-sprite-render) [551.551321] Subtest fbc-psr2-sprite-render: SKIP (0.000s) [551.617492] [120/133] (482s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [553.138160] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [553.139951] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [553.288770] [121/133] (480s left) perf_pmu (busy-idle-no-semaphores) [553.390364] Starting subtest: busy-idle-no-semaphores [553.391259] Starting dynamic subtest: rcs0 [554.081658] Dynamic subtest rcs0: SUCCESS (0.691s) [554.098837] Starting dynamic subtest: bcs0 [554.735199] Dynamic subtest bcs0: SUCCESS (0.650s) [554.750573] Starting dynamic subtest: vcs0 [555.390480] Dynamic subtest vcs0: SUCCESS (0.652s) [555.406546] Starting dynamic subtest: vcs1 [556.048308] Dynamic subtest vcs1: SUCCESS (0.654s) [556.063699] Starting dynamic subtest: vecs0 [556.702823] Dynamic subtest vecs0: SUCCESS (0.651s) [556.720707] Starting dynamic subtest: vecs1 [557.357280] Dynamic subtest vecs1: SUCCESS (0.651s) [557.374750] Starting dynamic subtest: ccs0 [558.011684] Dynamic subtest ccs0: SUCCESS (0.651s) [558.013179] Subtest busy-idle-no-semaphores: SUCCESS (4.624s) [558.200904] [122/133] (475s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [559.715901] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [559.717788] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [559.879602] [123/133] (474s left) kms_big_fb (4-tiled-16bpp-rotate-270) [561.430152] Starting subtest: 4-tiled-16bpp-rotate-270 [561.490221] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.059s) [561.689834] [124/133] (472s left) kms_flip (2x-absolute-wf_vblank) [563.205408] Starting subtest: 2x-absolute-wf_vblank [563.218123] Subtest 2x-absolute-wf_vblank: SKIP (0.013s) [563.413201] [125/133] (471s left) core_setmaster (master-drop-set-root) [563.505414] Starting subtest: master-drop-set-root [563.538672] Subtest master-drop-set-root: SUCCESS (0.033s) [563.620386] [126/133] (470s left) gem_ctx_param (invalid-param-set) [563.702769] Starting subtest: invalid-param-set [563.703630] Subtest invalid-param-set: SUCCESS (0.000s) [563.836940] [127/133] (470s left) kms_sequence (get-idle) [565.354163] Starting subtest: get-idle [565.355134] Starting dynamic subtest: pipe-A-HDMI-A-3 [567.712789] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.357s) [567.723718] Starting dynamic subtest: pipe-B-HDMI-A-3 [569.923998] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.209s) [569.935154] Starting dynamic subtest: pipe-C-HDMI-A-3 [572.142675] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.217s) [572.154854] Starting dynamic subtest: pipe-D-HDMI-A-3 [574.363403] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.219s) [574.364275] Subtest get-idle: SUCCESS (9.010s) [574.575302] [128/133] (460s left) gem_mmap_wc (invalid-flags) [574.659289] Subtest invalid-flags: SKIP (0.000s) [574.730783] [129/133] (459s left) kms_chamelium_frames (vga-frame-dump) [576.294348] Subtest vga-frame-dump: SKIP (0.000s) [576.401103] [130/133] (458s left) kms_flip (2x-flip-vs-dpms-on-nop) [577.925947] Starting subtest: 2x-flip-vs-dpms-on-nop [577.938392] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.013s) [578.067476] [131/133] (456s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [579.607130] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [579.608948] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [579.778816] [132/133] (455s left) gem_userptr_blits (unsync-unmap-cycles) [579.881934] Subtest unsync-unmap-cycles: SKIP (0.000s) [580.050307] [133/133] (454s left) fbdev (eof) [580.113820] Starting subtest: eof [580.114710] Subtest eof: SUCCESS (0.000s) [580.225692] 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.