[61.186548] Initializing watchdogs [61.186595] /dev/watchdog0 [61.201555] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [61.206091] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.208360] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.210190] [001/133] (960s left) kms_big_fb (4-tiled-64bpp-rotate-180) [61.320580] Starting subtest: 4-tiled-64bpp-rotate-180 [62.918970] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.590s) [63.079206] [002/133] (958s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [63.186345] Starting subtest: cursorA-vs-flipB-atomic-transitions [63.188070] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [63.325724] [003/133] (958s left) kms_ccs (random-ccs-data-y-tiled-ccs) [63.416122] Starting subtest: random-ccs-data-y-tiled-ccs [63.417091] Starting dynamic subtest: pipe-A-eDP-1 [63.426858] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [63.433788] Starting dynamic subtest: pipe-B-eDP-1 [63.443341] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [63.450153] Starting dynamic subtest: pipe-C-eDP-1 [63.459235] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [63.464801] Starting dynamic subtest: pipe-D-eDP-1 [63.473857] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [63.475603] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s) [65.955203] [004/133] (955s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0) [66.052558] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0 [66.054200] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [66.150932] [005/133] (955s left) gem_mmap_wc (write-read) [66.199770] Subtest write-read: SKIP (0.000s) [66.247838] [006/133] (955s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [66.300336] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [66.420939] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.109s) [66.479539] [007/133] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [66.580383] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [66.582165] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [66.670539] [008/133] (955s left) kms_chamelium_edid (hdmi-mode-timings) [67.095203] Subtest hdmi-mode-timings: SKIP (0.000s) [67.873042] [009/133] (954s left) gem_userptr_blits (nohangcheck) [68.068714] Starting subtest: nohangcheck [68.313286] Subtest nohangcheck: SUCCESS (0.242s) [68.425119] [010/133] (953s left) gem_create (create-massive) [68.470900] Starting subtest: create-massive [68.471818] Subtest create-massive: SUCCESS (0.000s) [68.647693] [011/133] (953s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [68.730783] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [76.147143] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.406s) [76.251807] [012/133] (945s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [76.360913] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [76.363192] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [76.459337] [013/133] (945s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt) [76.549682] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt [81.186571] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.633s) [82.323101] [014/133] (939s left) fbdev (read) [82.375079] Starting subtest: read [82.916874] Subtest read: SUCCESS (0.532s) [82.961829] [015/133] (939s left) sw_sync (sync_expired_merge) [82.996369] Starting subtest: sync_expired_merge [84.079872] Subtest sync_expired_merge: SUCCESS (1.074s) [84.126387] [016/133] (938s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [84.225300] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [84.226364] Starting dynamic subtest: pipe-A-eDP-1 [84.235036] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [84.242780] Starting dynamic subtest: pipe-B-eDP-1 [84.257490] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [84.263842] Starting dynamic subtest: pipe-C-eDP-1 [84.272317] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [84.278134] Starting dynamic subtest: pipe-D-eDP-1 [84.286320] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [84.287979] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s) [86.402809] [017/133] (935s left) perf_pmu (render-node-busy-idle) [86.463364] Starting subtest: render-node-busy-idle [86.464418] Starting dynamic subtest: rcs0 [87.160373] Dynamic subtest rcs0: SUCCESS (0.696s) [87.169057] Starting dynamic subtest: bcs0 [87.825994] Dynamic subtest bcs0: SUCCESS (0.664s) [87.835455] Starting dynamic subtest: vcs0 [89.887096] Dynamic subtest vcs0: SUCCESS (2.050s) [89.896633] Starting dynamic subtest: vcs1 [91.934687] Dynamic subtest vcs1: SUCCESS (2.045s) [91.943818] Starting dynamic subtest: vecs0 [93.917817] Dynamic subtest vecs0: SUCCESS (1.981s) [93.926945] Starting dynamic subtest: ccs0 [94.582273] Dynamic subtest ccs0: SUCCESS (0.672s) [94.583603] Subtest render-node-busy-idle: SUCCESS (8.115s) [94.651581] [018/133] (927s left) gem_exec_fence (syncobj-signal) [95.112488] Starting subtest: syncobj-signal [95.118271] Subtest syncobj-signal: SUCCESS (0.007s) [96.995926] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true [96.997664] [019/133] (925s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [97.092237] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [97.094139] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s) [97.159036] [020/133] (925s left) kms_flip (flip-vs-dpms-off-vs-modeset) [97.240032] Starting subtest: flip-vs-dpms-off-vs-modeset [97.242038] Starting dynamic subtest: A-eDP1 [100.848150] Dynamic subtest A-eDP1: SUCCESS (3.605s) [100.855222] Starting dynamic subtest: B-eDP1 [104.053361] Dynamic subtest B-eDP1: SUCCESS (3.202s) [104.061412] Starting dynamic subtest: C-eDP1 [107.257493] Dynamic subtest C-eDP1: SUCCESS (3.203s) [107.265502] Starting dynamic subtest: D-eDP1 [110.370548] Dynamic subtest D-eDP1: SUCCESS (3.112s) [110.372499] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.128s) [111.181735] [021/133] (911s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [111.300199] Starting subtest: cursorA-vs-flipB-varying-size [111.302048] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [111.477453] [022/133] (910s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [111.571201] Starting subtest: crc-primary-suspend-y-tiled-ccs [111.572044] Starting dynamic subtest: pipe-A-eDP-1 [111.575542] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [111.582775] Starting dynamic subtest: pipe-B-eDP-1 [111.586298] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [111.593051] Starting dynamic subtest: pipe-C-eDP-1 [111.596697] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [111.603388] Starting dynamic subtest: pipe-D-eDP-1 [111.606932] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [111.608603] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.003s) [113.824224] [023/133] (908s left) gem_render_copy_redux (flink) [113.876607] Starting subtest: flink [114.633127] Subtest flink: SUCCESS (0.756s) [114.755646] [024/133] (907s left) gem_exec_whisper (basic-queues) [114.817355] Starting subtest: basic-queues [120.935770] Subtest basic-queues: SUCCESS (6.107s) [121.118488] [025/133] (901s left) gem_ctx_isolation (nonpriv) [121.182882] Starting subtest: nonpriv [121.183840] Starting dynamic subtest: rcs0 [121.476190] Dynamic subtest rcs0: SUCCESS (0.293s) [121.485728] Starting dynamic subtest: bcs0 [121.776138] Dynamic subtest bcs0: SUCCESS (0.300s) [121.785571] Starting dynamic subtest: vcs0 [122.049144] Dynamic subtest vcs0: SUCCESS (0.273s) [122.058803] Starting dynamic subtest: vcs1 [124.089575] Dynamic subtest vcs1: SUCCESS (2.039s) [124.099075] Starting dynamic subtest: vecs0 [126.184205] Dynamic subtest vecs0: SUCCESS (2.094s) [126.191132] Starting dynamic subtest: ccs0 [128.167220] Dynamic subtest ccs0: SUCCESS (1.982s) [128.168235] Subtest nonpriv: SUCCESS (6.983s) [128.392848] [026/133] (894s left) kms_getfb (getfb2-handle-zero) [128.487979] Starting subtest: getfb2-handle-zero [128.488873] Subtest getfb2-handle-zero: SUCCESS (0.000s) [128.575958] [027/133] (894s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [128.662402] Starting subtest: primary-y-tiled-reflect-x-270 [128.664401] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [128.732715] [028/133] (893s left) kms_plane_cursor (overlay) [128.831067] Starting subtest: overlay [128.832876] Starting dynamic subtest: pipe-A-eDP-1-size-64 [131.340255] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.509s) [131.400897] Starting dynamic subtest: pipe-A-eDP-1-size-128 [133.953627] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.561s) [134.016347] Starting dynamic subtest: pipe-A-eDP-1-size-256 [136.554202] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.550s) [136.903615] Starting dynamic subtest: pipe-B-eDP-1-size-64 [140.275838] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.379s) [140.336941] Starting dynamic subtest: pipe-B-eDP-1-size-128 [142.811102] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.483s) [142.871317] Starting dynamic subtest: pipe-B-eDP-1-size-256 [145.345086] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.483s) [145.702578] Starting dynamic subtest: pipe-C-eDP-1-size-64 [148.603512] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.908s) [148.641476] Starting dynamic subtest: pipe-C-eDP-1-size-128 [150.848286] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s) [150.884861] Starting dynamic subtest: pipe-C-eDP-1-size-256 [153.059473] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s) [153.384806] Starting dynamic subtest: pipe-D-eDP-1-size-64 [156.278994] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.901s) [156.316358] Starting dynamic subtest: pipe-D-eDP-1-size-128 [158.456990] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.147s) [158.497917] Starting dynamic subtest: pipe-D-eDP-1-size-256 [160.779445] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.292s) [161.104829] Subtest overlay: SUCCESS (32.272s) [161.951789] [029/133] (860s left) gem_exec_balancer (hang) [162.223222] Starting subtest: hang [163.940474] Subtest hang: SUCCESS (1.728s) [164.076323] [030/133] (858s left) gem_exec_schedule (submit-early-slice) [164.136128] Starting subtest: submit-early-slice [164.137066] Starting dynamic subtest: rcs0 [164.177616] Dynamic subtest rcs0: SUCCESS (0.041s) [164.185388] Starting dynamic subtest: bcs0 [164.213853] Dynamic subtest bcs0: SUCCESS (0.036s) [164.222283] Starting dynamic subtest: vcs0 [164.252996] Dynamic subtest vcs0: SUCCESS (0.038s) [164.260544] Starting dynamic subtest: vcs1 [164.291960] Dynamic subtest vcs1: SUCCESS (0.038s) [164.300996] Starting dynamic subtest: vecs0 [164.329945] Dynamic subtest vecs0: SUCCESS (0.037s) [164.338885] Starting dynamic subtest: ccs0 [164.367817] Dynamic subtest ccs0: SUCCESS (0.037s) [164.369042] Subtest submit-early-slice: SUCCESS (0.232s) [165.982879] [031/133] (856s left) kms_draw_crc (draw-method-mmap-cpu) [166.080415] Starting subtest: draw-method-mmap-cpu [166.081319] Starting dynamic subtest: xrgb8888-untiled [166.323517] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s) [166.331940] Starting dynamic subtest: rgb565-untiled [166.567923] Dynamic subtest rgb565-untiled: SUCCESS (0.243s) [166.577746] Starting dynamic subtest: xrgb2101010-untiled [166.790207] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s) [166.797738] Starting dynamic subtest: xbgr16161616f-untiled [167.023422] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s) [167.030709] Starting dynamic subtest: xrgb8888-xtiled [167.156865] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [167.164127] Starting dynamic subtest: rgb565-xtiled [167.278851] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s) [167.286293] Starting dynamic subtest: xrgb2101010-xtiled [167.405536] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [167.412832] Starting dynamic subtest: xbgr16161616f-xtiled [167.534602] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [167.543117] Starting dynamic subtest: xrgb8888-4tiled [167.690159] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.153s) [167.697252] Starting dynamic subtest: rgb565-4tiled [167.834761] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [167.842679] Starting dynamic subtest: xrgb2101010-4tiled [167.967972] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s) [167.976495] Starting dynamic subtest: xbgr16161616f-4tiled [168.112419] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.142s) [168.114749] Subtest draw-method-mmap-cpu: SUCCESS (2.034s) [168.203805] [032/133] (854s left) gen9_exec_parse (basic-rejected) [168.252020] Subtest basic-rejected: SKIP (0.000s) [168.325679] [033/133] (854s left) kms_vblank (accuracy-idle) [168.416637] Starting subtest: accuracy-idle [168.417485] Starting dynamic subtest: pipe-A-eDP-1 [170.170556] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s) [170.179469] Starting dynamic subtest: pipe-D-eDP-1 [172.604491] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.432s) [172.605229] Subtest accuracy-idle: SUCCESS (4.188s) [173.419658] [034/133] (849s left) sw_sync (alloc_fence) [173.449630] Starting subtest: alloc_fence [173.450780] Subtest alloc_fence: SUCCESS (0.000s) [173.498714] [035/133] (849s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [173.588397] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [173.589284] Starting dynamic subtest: pipe-A [173.607881] Dynamic subtest pipe-A: SKIP (0.018s) [173.615207] Starting dynamic subtest: pipe-B [173.639521] Dynamic subtest pipe-B: SKIP (0.030s) [173.646438] Starting dynamic subtest: pipe-C [173.669287] Dynamic subtest pipe-C: SKIP (0.030s) [173.676194] Starting dynamic subtest: pipe-D [173.704500] Dynamic subtest pipe-D: SKIP (0.034s) [173.706187] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.115s) [173.803621] [036/133] (849s left) perf (invalid-create-userspace-config) [173.917944] Starting subtest: invalid-create-userspace-config [173.918811] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [173.959575] [037/133] (848s left) api_intel_allocator (simple-allocator) [174.004493] Starting subtest: simple-allocator [174.005332] Starting dynamic subtest: basic [174.007046] Dynamic subtest basic: SUCCESS (0.004s) [174.015367] Starting dynamic subtest: parallel-one [174.197812] Dynamic subtest parallel-one: SUCCESS (0.183s) [174.207297] Starting dynamic subtest: print [174.208262] Dynamic subtest print: SUCCESS (0.000s) [174.215104] Starting dynamic subtest: reuse [174.215925] Dynamic subtest reuse: SUCCESS (0.000s) [174.222625] Starting dynamic subtest: reserve [174.223430] Dynamic subtest reserve: SUCCESS (0.000s) [174.230341] Starting dynamic subtest: fork-reopen-allocator [174.231088] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s) [174.231897] Subtest simple-allocator: SUCCESS (0.203s) [174.347902] [038/133] (848s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [174.434450] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [174.435380] Starting dynamic subtest: pipe-A-eDP-1 [174.455173] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s) [174.463433] Starting dynamic subtest: pipe-B-eDP-1 [174.476572] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s) [174.484964] Starting dynamic subtest: pipe-C-eDP-1 [174.497356] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s) [174.505712] Starting dynamic subtest: pipe-D-eDP-1 [174.519645] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s) [174.520535] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s) [176.778111] [039/133] (846s left) gem_ctx_create (basic) [176.840118] Starting subtest: basic [176.840999] Subtest basic: SUCCESS (0.000s) [177.020891] [040/133] (846s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [177.110278] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [177.111963] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [177.210774] [041/133] (845s left) kms_psr (psr2-cursor-mmap-gtt) [177.310594] Starting subtest: psr2-cursor-mmap-gtt [177.311474] Starting dynamic subtest: eDP-1 [179.060041] Dynamic subtest eDP-1: SUCCESS (1.750s) [179.060945] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.751s) [179.867826] [042/133] (843s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render) [179.963362] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render [179.965099] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [180.058988] [043/133] (843s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [180.154686] Starting subtest: bad-rotation-90-yf-tiled-ccs [180.155591] Starting dynamic subtest: pipe-A-eDP-1 [180.164185] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [180.171592] Starting dynamic subtest: pipe-B-eDP-1 [180.179648] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [180.186788] Starting dynamic subtest: pipe-C-eDP-1 [180.194349] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [180.201038] Starting dynamic subtest: pipe-D-eDP-1 [180.209221] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [180.210855] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.005s) [182.420615] [044/133] (840s left) kms_color_pipeline (plane-ctm3x4-lut1d) [182.510408] Starting subtest: plane-ctm3x4-lut1d [182.657955] Starting dynamic subtest: pipe-A-plane-0 [182.925281] Dynamic subtest pipe-A-plane-0: FAIL (0.202s) [182.933280] Starting dynamic subtest: pipe-A-plane-1 [183.118251] Dynamic subtest pipe-A-plane-1: FAIL (0.182s) [183.125900] Starting dynamic subtest: pipe-A-plane-2 [183.315322] Dynamic subtest pipe-A-plane-2: FAIL (0.177s) [184.405857] Starting dynamic subtest: pipe-B-plane-0 [184.696154] Dynamic subtest pipe-B-plane-0: FAIL (0.197s) [184.703829] Starting dynamic subtest: pipe-B-plane-1 [184.866898] Dynamic subtest pipe-B-plane-1: FAIL (0.165s) [184.874312] Starting dynamic subtest: pipe-B-plane-2 [185.056790] Dynamic subtest pipe-B-plane-2: FAIL (0.178s) [186.150359] Starting dynamic subtest: pipe-C-plane-0 [186.412573] Dynamic subtest pipe-C-plane-0: FAIL (0.139s) [186.420175] Starting dynamic subtest: pipe-C-plane-1 [186.569338] Dynamic subtest pipe-C-plane-1: FAIL (0.144s) [186.577330] Starting dynamic subtest: pipe-C-plane-2 [186.755415] Dynamic subtest pipe-C-plane-2: FAIL (0.166s) [187.770045] Starting dynamic subtest: pipe-D-plane-0 [188.077528] Dynamic subtest pipe-D-plane-0: FAIL (0.151s) [188.085164] Starting dynamic subtest: pipe-D-plane-1 [188.264558] Dynamic subtest pipe-D-plane-1: FAIL (0.144s) [188.272205] Starting dynamic subtest: pipe-D-plane-2 [188.465800] Dynamic subtest pipe-D-plane-2: FAIL (0.333s) [188.700599] Subtest plane-ctm3x4-lut1d: FAIL (6.190s) [189.559472] [045/133] (833s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [189.660517] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [189.662236] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [189.768980] [046/133] (833s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area) [189.857841] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area [189.858869] Starting dynamic subtest: pipe-A-eDP-1 [189.946927] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s) [189.955192] Starting dynamic subtest: pipe-B-eDP-1 [191.137878] Dynamic subtest pipe-B-eDP-1: SKIP (1.189s) [191.139624] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.281s) [192.323893] [047/133] (830s left) kms_flip (2x-dpms-vs-vblank-race-interruptible) [192.422980] Starting subtest: 2x-dpms-vs-vblank-race-interruptible [192.434125] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s) [192.513779] [048/133] (830s left) gem_exec_endless (dispatch) [192.597078] Starting subtest: dispatch [192.598085] Starting dynamic subtest: rcs0 [192.601529] Dynamic subtest rcs0: SUCCESS (0.005s) [192.609435] Starting dynamic subtest: bcs0 [192.611088] Dynamic subtest bcs0: SUCCESS (0.004s) [192.618894] Starting dynamic subtest: vcs0 [192.620940] Dynamic subtest vcs0: SUCCESS (0.005s) [192.629576] Starting dynamic subtest: vcs1 [192.631373] Dynamic subtest vcs1: SUCCESS (0.005s) [192.638246] Starting dynamic subtest: vecs0 [192.639842] Dynamic subtest vecs0: SUCCESS (0.004s) [192.646753] Starting dynamic subtest: ccs0 [192.648470] Dynamic subtest ccs0: SUCCESS (0.004s) [192.649347] Subtest dispatch: SUCCESS (0.032s) [193.912568] [049/133] (829s left) kms_pm_rpm (dpms-mode-unset-lpsp) [196.036090] Starting subtest: dpms-mode-unset-lpsp [200.105711] Subtest dpms-mode-unset-lpsp: SUCCESS (4.070s) [200.494114] [050/133] (822s left) kms_vblank (wait-busy-hang) [200.584481] Starting subtest: wait-busy-hang [200.585345] Starting dynamic subtest: pipe-A-eDP-1 [226.644429] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.057s) [226.653248] Starting dynamic subtest: pipe-D-eDP-1 [251.676652] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.028s) [251.677580] Subtest wait-busy-hang: SUCCESS (51.089s) [252.549385] [051/133] (770s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [252.633409] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [252.634919] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [252.748554] [052/133] (770s left) gem_softpin (safe-alignment) [252.806382] Starting subtest: safe-alignment [252.829226] Subtest safe-alignment: SUCCESS (0.023s) [253.957097] [053/133] (769s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [254.004272] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [254.005191] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s) [254.124052] [054/133] (769s left) kms_psr (fbc-psr2-cursor-plane-onoff) [254.212359] Starting subtest: fbc-psr2-cursor-plane-onoff [254.213270] Starting dynamic subtest: eDP-1 [254.214948] Dynamic subtest eDP-1: SKIP (0.000s) [254.216773] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [254.280320] [055/133] (769s left) gem_exec_schedule (manyslice) [254.349286] Starting subtest: manyslice [254.350122] Starting dynamic subtest: rcs0 [259.533503] Dynamic subtest rcs0: SUCCESS (5.139s) [259.544785] Starting dynamic subtest: bcs0 [265.654380] Dynamic subtest bcs0: SUCCESS (6.118s) [265.661983] Starting dynamic subtest: vcs0 [271.748896] Dynamic subtest vcs0: SUCCESS (6.091s) [271.760829] Starting dynamic subtest: vcs1 [277.324509] Dynamic subtest vcs1: SUCCESS (5.574s) [277.332615] Starting dynamic subtest: vecs0 [283.392587] Dynamic subtest vecs0: SUCCESS (6.067s) [283.402577] Starting dynamic subtest: ccs0 [290.103926] Dynamic subtest ccs0: SUCCESS (6.709s) [290.105423] Subtest manyslice: SUCCESS (35.709s) [290.358310] [056/133] (733s left) kms_content_protection (dp-mst-type-0) [290.508620] Starting subtest: dp-mst-type-0 [290.510520] Subtest dp-mst-type-0: SKIP (0.000s) [290.630997] [057/133] (732s left) gem_ctx_persistence (heartbeat-many) [290.691670] Starting subtest: heartbeat-many [290.693406] Subtest heartbeat-many: SKIP (0.000s) [290.787376] [058/133] (732s left) kms_async_flips (test-cursor-atomic) [290.876497] Starting subtest: test-cursor-atomic [291.261463] Starting dynamic subtest: pipe-A-eDP-1 [292.021319] Dynamic subtest pipe-A-eDP-1: SKIP (0.759s) [292.401302] Starting dynamic subtest: pipe-B-eDP-1 [293.154041] Dynamic subtest pipe-B-eDP-1: SKIP (0.758s) [293.545681] Starting dynamic subtest: pipe-C-eDP-1 [294.289456] Dynamic subtest pipe-C-eDP-1: SKIP (0.751s) [294.649938] Starting dynamic subtest: pipe-D-eDP-1 [295.423592] Dynamic subtest pipe-D-eDP-1: SKIP (0.779s) [295.425498] Subtest test-cursor-atomic: SKIP (4.547s) [296.602776] [059/133] (727s left) syncobj_wait (wait-all-complex) [296.663541] Starting subtest: wait-all-complex [296.889509] Subtest wait-all-complex: SUCCESS (0.217s) [296.953544] [060/133] (726s left) kms_psr (fbc-psr-cursor-blt) [297.038262] Starting subtest: fbc-psr-cursor-blt [297.039235] Starting dynamic subtest: eDP-1 [297.040924] Dynamic subtest eDP-1: SKIP (0.000s) [297.042552] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [297.111715] [061/133] (726s left) i915_suspend (sysfs-reader) [297.166063] Starting subtest: sysfs-reader [314.979453] Subtest sysfs-reader: SUCCESS (4.402s) [322.109746] [062/133] (708s left) kms_cursor_crc (cursor-onscreen-256x85) [322.377410] Starting subtest: cursor-onscreen-256x85 [322.423847] Subtest cursor-onscreen-256x85: SKIP (0.043s) [322.600228] [063/133] (708s left) kms_cursor_crc (cursor-random-max-size) [322.911961] Starting subtest: cursor-random-max-size [322.914484] Subtest cursor-random-max-size: SKIP (0.000s) [323.036527] [064/133] (707s left) syncobj_timeline (wait-all-snapshot) [323.095778] Starting subtest: wait-all-snapshot [323.179685] Subtest wait-all-snapshot: SUCCESS (0.080s) [323.266692] [065/133] (707s left) kms_cursor_legacy (single-move) [323.384137] Starting subtest: single-move [323.385081] Starting dynamic subtest: pipe-A [328.958855] Dynamic subtest pipe-A: SUCCESS (5.380s) [328.968987] Starting dynamic subtest: pipe-B [334.412737] Dynamic subtest pipe-B: SUCCESS (5.380s) [334.422961] Starting dynamic subtest: pipe-C [339.830591] Dynamic subtest pipe-C: SUCCESS (5.379s) [339.840647] Starting dynamic subtest: pipe-D [345.231331] Dynamic subtest pipe-D: SUCCESS (5.379s) [345.240809] Starting dynamic subtest: all-pipes [350.629269] Dynamic subtest all-pipes: SUCCESS (5.387s) [350.630344] Subtest single-move: SUCCESS (26.918s) [350.722626] [066/133] (680s left) gem_exec_nop (basic-series) [350.798072] Starting subtest: basic-series [367.364914] Subtest basic-series: SUCCESS (16.543s) [367.566547] [067/133] (663s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [367.670753] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [367.672403] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [367.764449] [068/133] (663s left) sw_sync (sync_busy) [367.800766] Starting subtest: sync_busy [367.802846] Subtest sync_busy: SUCCESS (0.002s) [367.849648] [069/133] (663s left) kms_flip_event_leak (basic) [367.928104] Starting subtest: basic [367.928931] Starting dynamic subtest: pipe-A-eDP-1 [368.349669] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s) [368.358202] Starting dynamic subtest: pipe-B-eDP-1 [369.516338] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.164s) [369.524460] Starting dynamic subtest: pipe-C-eDP-1 [370.642674] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s) [370.651303] Starting dynamic subtest: pipe-D-eDP-1 [371.772284] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s) [371.773215] Subtest basic: SUCCESS (3.842s) [372.624298] [070/133] (658s left) kms_properties (colorop-properties-legacy) [372.718316] Starting subtest: colorop-properties-legacy [372.719203] Starting dynamic subtest: pipe-A-eDP-1 [373.085287] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.367s) [373.094921] Starting dynamic subtest: pipe-B-eDP-1 [374.208019] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.119s) [374.216357] Starting dynamic subtest: pipe-C-eDP-1 [375.238285] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.029s) [375.247231] Starting dynamic subtest: pipe-D-eDP-1 [376.266237] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.026s) [376.267114] Subtest colorop-properties-legacy: SUCCESS (3.546s) [377.070437] [071/133] (654s left) i915_getparams_basic (basic-subslice-total) [377.123198] Starting subtest: basic-subslice-total [377.124937] Subtest basic-subslice-total: SUCCESS (0.000s) [377.209196] [072/133] (654s left) syncobj_timeline (wait-any-snapshot) [377.258621] Starting subtest: wait-any-snapshot [377.340667] Subtest wait-any-snapshot: SUCCESS (0.081s) [377.414941] [073/133] (653s left) i915_pm_rps (min-max-config-loaded) [377.479065] Starting subtest: min-max-config-loaded [377.480771] Subtest min-max-config-loaded: SKIP (0.000s) [377.573415] [074/133] (653s left) kms_plane_lowres (tiling-x) [377.669149] Starting subtest: tiling-x [377.670029] Starting dynamic subtest: pipe-A-eDP-1 [377.671820] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [377.966355] Starting dynamic subtest: pipe-B-eDP-1 [377.967943] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [377.975796] Starting dynamic subtest: pipe-C-eDP-1 [377.977445] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [377.985184] Starting dynamic subtest: pipe-D-eDP-1 [377.986774] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [377.988357] Subtest tiling-x: SKIP (0.296s) [378.786320] [075/133] (652s left) gem_userptr_blits (map-fixed-invalidate-busy) [378.845153] Starting subtest: map-fixed-invalidate-busy [378.847143] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [378.953459] [076/133] (652s left) kms_invalid_mode (clock-too-high) [379.050463] Starting subtest: clock-too-high [379.051309] Starting dynamic subtest: pipe-A-eDP-1 [379.052958] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [379.064049] Starting dynamic subtest: pipe-B-eDP-1 [379.065559] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [379.073309] Starting dynamic subtest: pipe-C-eDP-1 [379.076612] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [379.085481] Starting dynamic subtest: pipe-D-eDP-1 [379.087616] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [379.089197] Subtest clock-too-high: SKIP (0.005s) [379.136026] [077/133] (652s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [379.227177] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [379.228733] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s) [379.294649] [078/133] (652s left) syncobj_eventfd (timeline-wait-signaled) [379.342422] Starting subtest: timeline-wait-signaled [379.343323] Subtest timeline-wait-signaled: SUCCESS (0.000s) [379.427051] [079/133] (652s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [379.523783] Starting subtest: fbcpsr-farfromfence-mmap-gtt [379.525400] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [379.620058] [080/133] (651s left) gem_mmap_offset (bad-object) [379.671201] Starting subtest: bad-object [379.672061] Subtest bad-object: SUCCESS (0.001s) [379.760163] [081/133] (651s left) kms_addfb_basic (addfb25-4-tiled) [379.845007] Starting subtest: addfb25-4-tiled [379.845831] Subtest addfb25-4-tiled: SUCCESS (0.000s) [379.948841] [082/133] (651s left) api_intel_bb (simple-bb) [380.003314] Starting subtest: simple-bb [380.008731] Subtest simple-bb: SUCCESS (0.006s) [380.117609] [083/133] (651s left) gem_mmap_wc (write-read-distinct) [380.168500] Subtest write-read-distinct: SKIP (0.000s) [380.223372] [084/133] (651s left) kms_prime (basic-modeset-hybrid) [380.306014] Subtest basic-modeset-hybrid: SKIP (0.000s) [380.400402] [085/133] (651s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [380.442157] Starting subtest: single-wait-all-for-submit-unsubmitted [380.553593] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s) [380.625513] [086/133] (651s left) kms_lease (lease-get) [380.704899] Starting subtest: lease-get [380.705827] Starting dynamic subtest: pipe-A-eDP-1 [380.706609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [380.716352] Starting dynamic subtest: pipe-B-eDP-1 [380.717139] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [380.726060] Starting dynamic subtest: pipe-C-eDP-1 [380.726886] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [380.734907] Starting dynamic subtest: pipe-D-eDP-1 [380.735825] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [380.736580] Subtest lease-get: SUCCESS (0.012s) [380.806595] [087/133] (650s left) kms_busy (extended-modeset-hang-newfb) [380.890309] Starting subtest: extended-modeset-hang-newfb [380.891267] Starting dynamic subtest: pipe-A [415.308922] Dynamic subtest pipe-A: SUCCESS (34.404s) [415.319172] Starting dynamic subtest: pipe-D [438.241822] Dynamic subtest pipe-D: SUCCESS (22.936s) [438.243809] Subtest extended-modeset-hang-newfb: SUCCESS (57.345s) [439.033162] [088/133] (592s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [439.123589] Starting subtest: 2x-flip-vs-absolute-wf_vblank [439.134097] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s) [439.207383] [089/133] (592s left) kms_plane (pixel-format-x-tiled-modifier) [439.292926] Starting subtest: pixel-format-x-tiled-modifier [439.320930] Starting dynamic subtest: pipe-A-plane-0 [439.943635] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s) [439.953331] Starting dynamic subtest: pipe-A-plane-3 [440.353916] Dynamic subtest pipe-A-plane-3: SUCCESS (0.409s) [440.362447] Starting dynamic subtest: pipe-A-plane-5 [440.364256] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [441.416526] Starting dynamic subtest: pipe-B-plane-0 [442.041139] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s) [442.050666] Starting dynamic subtest: pipe-B-plane-3 [442.441184] Dynamic subtest pipe-B-plane-3: SUCCESS (0.399s) [442.451363] Starting dynamic subtest: pipe-B-plane-5 [442.453168] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [442.769263] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.476s) [443.593848] [090/133] (588s left) prime_vgem (basic-fence-flip) [443.653274] Starting subtest: basic-fence-flip [443.965222] Subtest basic-fence-flip: SUCCESS (0.312s) [444.092677] [091/133] (587s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [444.172790] Starting subtest: plane-use-after-nonblocking-unbind-fencing [444.173638] Starting dynamic subtest: pipe-A-eDP-1 [444.237502] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s) [444.546084] Starting dynamic subtest: pipe-B-eDP-1 [445.309071] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.771s) [445.599063] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.426s) [446.458704] [092/133] (585s left) kms_big_fb (linear-8bpp-rotate-0) [446.559346] Starting subtest: linear-8bpp-rotate-0 [447.794883] Subtest linear-8bpp-rotate-0: SUCCESS (1.236s) [447.914683] [093/133] (584s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [447.966981] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [447.968738] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [448.151277] [094/133] (583s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [448.254197] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [448.255804] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [448.348313] [095/133] (583s left) gem_eio (kms) [448.628449] Starting subtest: kms [469.386831] Subtest kms: SUCCESS (20.744s) [470.571229] [096/133] (561s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [470.684098] Starting subtest: verify-pxp-stale-buf-optout-execution [471.745301] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.061s) [471.858371] [097/133] (560s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [471.906944] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [471.907913] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [472.006716] [098/133] (560s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [472.051854] Starting subtest: invalid-multi-wait-all-unsubmitted [472.052696] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [472.161695] [099/133] (560s left) syncobj_wait (single-wait-all-for-submit-submitted) [472.211383] Starting subtest: single-wait-all-for-submit-submitted [472.317581] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.105s) [472.405967] [100/133] (559s left) syncobj_wait (invalid-signal-one-illegal-handle) [472.463655] Starting subtest: invalid-signal-one-illegal-handle [472.464610] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [472.566162] [101/133] (559s left) kms_chamelium_hpd (vga-hpd-fast) [472.945736] Subtest vga-hpd-fast: SKIP (0.000s) [473.762674] [102/133] (558s left) kms_force_connector_basic (force-load-detect) [473.850577] Starting subtest: force-load-detect [473.852478] Subtest force-load-detect: SKIP (0.000s) [473.974014] [103/133] (558s left) gem_pwrite (basic-exhaustion) [474.031563] Subtest basic-exhaustion: SKIP (0.000s) [474.091333] [104/133] (558s left) kms_psr (pr-suspend) [474.176257] Starting subtest: pr-suspend [474.178112] Subtest pr-suspend: SKIP (0.000s) [474.245557] [105/133] (558s left) syncobj_timeline (invalid-query-bad-pad) [474.292540] Starting subtest: invalid-query-bad-pad [474.293416] Subtest invalid-query-bad-pad: SUCCESS (0.000s) [474.393030] [106/133] (558s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [474.476284] Starting subtest: plane-scaler-unity-scaling-with-rotation [474.477272] Starting dynamic subtest: pipe-A [474.726070] Dynamic subtest pipe-A: SUCCESS (0.250s) [474.737711] Starting dynamic subtest: pipe-B [476.078075] Dynamic subtest pipe-B: SUCCESS (1.350s) [476.088107] Starting dynamic subtest: pipe-C [477.404936] Dynamic subtest pipe-C: SUCCESS (1.325s) [477.413775] Starting dynamic subtest: pipe-D [478.754702] Dynamic subtest pipe-D: SUCCESS (1.348s) [478.757012] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.280s) [480.111410] [107/133] (552s left) gem_exec_create (forked) [480.184254] Starting subtest: forked [480.185235] Starting dynamic subtest: smem [502.339625] Dynamic subtest smem: SUCCESS (22.138s) [502.341143] Subtest forked: SUCCESS (22.140s) [502.513982] [108/133] (529s left) core_getversion (all-cards) [502.560202] Starting subtest: all-cards [502.571403] Subtest all-cards: SUCCESS (0.012s) [502.610831] [109/133] (529s left) gem_mmap_wc (write-cpu-read-wc) [502.659481] Subtest write-cpu-read-wc: SKIP (0.000s) [502.716101] [110/133] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [502.815210] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [510.021554] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.207s) [510.156903] [111/133] (522s left) kms_flip (flip-vs-expired-vblank) [510.244108] Starting subtest: flip-vs-expired-vblank [510.246468] Starting dynamic subtest: A-eDP1 [518.997092] Dynamic subtest A-eDP1: SUCCESS (8.720s) [519.008467] Starting dynamic subtest: B-eDP1 [527.646281] Dynamic subtest B-eDP1: SUCCESS (8.642s) [527.657345] Starting dynamic subtest: C-eDP1 [536.375961] Dynamic subtest C-eDP1: SUCCESS (8.715s) [536.385251] Starting dynamic subtest: D-eDP1 [545.015039] Dynamic subtest D-eDP1: SUCCESS (8.638s) [545.016103] Subtest flip-vs-expired-vblank: SUCCESS (34.729s) [546.132792] [112/133] (486s left) kms_big_fb (x-tiled-32bpp-rotate-0) [546.225750] Starting subtest: x-tiled-32bpp-rotate-0 [547.716030] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.491s) [547.848363] [113/133] (484s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [547.936329] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [547.937833] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [548.024750] [114/133] (484s left) perf_pmu (pmu-read) [548.063258] Starting subtest: pmu-read [548.065963] Subtest pmu-read: SUCCESS (0.003s) [548.159451] [115/133] (484s left) gem_mmap_gtt (basic) [548.207711] Subtest basic: SKIP (0.000s) [548.261248] [116/133] (484s left) kms_flip (2x-plain-flip-ts-check-interruptible) [548.355790] Starting subtest: 2x-plain-flip-ts-check-interruptible [548.366598] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s) [548.462574] [117/133] (484s left) sw_sync (timeline_closed_signaled) [548.501039] Starting subtest: timeline_closed_signaled [548.502068] Subtest timeline_closed_signaled: SUCCESS (0.000s) [548.545919] [118/133] (484s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [548.636613] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [548.638370] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [548.756489] [119/133] (484s left) gem_exec_reloc (basic-scanout) [548.817533] Subtest basic-scanout: SKIP (0.000s) [548.878130] [120/133] (484s left) syncobj_wait (wait-all-for-submit-delayed-submit) [548.923599] Starting subtest: wait-all-for-submit-delayed-submit [549.026636] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s) [549.111461] [121/133] (483s left) i915_drm_fdinfo (busy-hang) [549.149991] Starting subtest: busy-hang [549.150843] Starting dynamic subtest: rcs0 [549.173119] Dynamic subtest rcs0: SKIP (0.023s) [549.183027] Starting dynamic subtest: bcs0 [549.184628] Dynamic subtest bcs0: SKIP (0.001s) [549.193372] Starting dynamic subtest: vcs0 [549.195028] Dynamic subtest vcs0: SKIP (0.000s) [549.203328] Starting dynamic subtest: vcs1 [549.205006] Dynamic subtest vcs1: SKIP (0.000s) [549.213219] Starting dynamic subtest: vecs0 [549.214824] Dynamic subtest vecs0: SKIP (0.000s) [549.223030] Starting dynamic subtest: ccs0 [549.224627] Dynamic subtest ccs0: SKIP (0.001s) [549.226310] Subtest busy-hang: SKIP (0.029s) [549.256018] [122/133] (483s left) kms_cursor_edge_walk (256x256-right-edge) [549.345185] Starting subtest: 256x256-right-edge [549.346073] Starting dynamic subtest: pipe-A-eDP-1 [552.810351] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.466s) [552.820747] Starting dynamic subtest: pipe-D-eDP-1 [555.930974] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s) [555.931723] Subtest 256x256-right-edge: SUCCESS (6.589s) [556.737815] [123/133] (476s left) kms_atomic_interruptible (legacy-dpms) [556.844142] Starting subtest: legacy-dpms [556.845135] Starting dynamic subtest: pipe-A-eDP-1 [564.269257] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.425s) [564.270128] Subtest legacy-dpms: SUCCESS (7.427s) [565.116712] [124/133] (467s left) syncobj_wait (wait-all-for-submit-complex) [565.173620] Starting subtest: wait-all-for-submit-complex [565.395699] Subtest wait-all-for-submit-complex: SUCCESS (0.213s) [565.489552] [125/133] (467s left) kms_psr (fbc-pr-cursor-plane-move) [565.585406] Starting subtest: fbc-pr-cursor-plane-move [565.587223] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [565.672730] [126/133] (467s left) kms_vrr (seamless-rr-switch-vrr) [565.772062] Starting subtest: seamless-rr-switch-vrr [565.774422] Subtest seamless-rr-switch-vrr: SKIP (0.000s) [565.840905] [127/133] (467s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [565.926601] Starting subtest: fbcpsr-rgb565-draw-pwrite [573.019879] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.096s) [573.132753] [128/133] (460s left) kms_psr (psr-sprite-render) [573.229268] Starting subtest: psr-sprite-render [573.230160] Starting dynamic subtest: eDP-1 [574.963644] Dynamic subtest eDP-1: SUCCESS (1.733s) [574.964601] Subtest psr-sprite-render: SUCCESS (1.735s) [575.798722] [129/133] (457s left) gem_mmap_gtt (cpuset-medium-copy-odd) [575.843920] Subtest cpuset-medium-copy-odd: SKIP (0.000s) [575.903998] [130/133] (457s left) prime_mmap (test_userptr) [575.956929] Starting subtest: test_userptr [575.957953] Starting dynamic subtest: test_userptr-smem [575.958928] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [575.959906] Subtest test_userptr: SUCCESS (0.001s) [576.045310] [131/133] (457s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [576.142599] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [576.801387] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s) [576.962759] [132/133] (456s left) prime_mmap (test_aperture_limit) [577.009518] Starting subtest: test_aperture_limit [577.010393] Starting dynamic subtest: test_aperture_limit-smem [577.018279] Dynamic subtest test_aperture_limit-smem: SKIP (0.009s) [577.020356] Subtest test_aperture_limit: SKIP (0.009s) [577.108372] [133/133] (456s left) gem_lmem_swapping (basic) [577.145958] Subtest basic: SKIP (0.000s) [577.194352] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: kms_cursor_legacy results: parsing output: 2/ for test: kms_ccs results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: gem_mmap_wc results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_chamelium_edid results: parsing output: 8/ for test: gem_userptr_blits results: parsing output: 9/ for test: gem_create results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: fbdev results: parsing output: 14/ for test: sw_sync results: parsing output: 15/ for test: kms_ccs results: parsing output: 16/ for test: perf_pmu results: parsing output: 17/ for test: gem_exec_fence results: parsing output: 18/ for test: kms_flip_scaled_crc results: parsing output: 19/ for test: kms_flip results: parsing output: 20/ for test: kms_cursor_legacy results: parsing output: 21/ for test: kms_ccs results: parsing output: 22/ for test: gem_render_copy_redux results: parsing output: 23/ for test: gem_exec_whisper results: parsing output: 24/ for test: gem_ctx_isolation results: parsing output: 25/ for test: kms_getfb results: parsing output: 26/ for test: kms_rotation_crc results: parsing output: 27/ for test: kms_plane_cursor results: parsing output: 28/ for test: gem_exec_balancer results: parsing output: 29/ for test: gem_exec_schedule results: parsing output: 30/ for test: kms_draw_crc results: parsing output: 31/ for test: gen9_exec_parse results: parsing output: 32/ for test: kms_vblank results: parsing output: 33/ for test: sw_sync results: parsing output: 34/ for test: kms_plane_scaling results: parsing output: 35/ for test: perf results: parsing output: 36/ for test: api_intel_allocator results: parsing output: 37/ for test: kms_ccs results: parsing output: 38/ for test: gem_ctx_create results: parsing output: 39/ for test: kms_big_fb results: parsing output: 40/ for test: kms_psr results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_ccs results: parsing output: 43/ for test: kms_color_pipeline results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_psr2_sf results: parsing output: 46/ for test: kms_flip results: parsing output: 47/ for test: gem_exec_endless results: parsing output: 48/ for test: kms_pm_rpm results: parsing output: 49/ for test: kms_vblank results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_softpin results: parsing output: 52/ for test: syncobj_timeline results: parsing output: 53/ for test: kms_psr results: parsing output: 54/ for test: gem_exec_schedule results: parsing output: 55/ for test: kms_content_protection results: parsing output: 56/ for test: gem_ctx_persistence results: parsing output: 57/ for test: kms_async_flips results: parsing output: 58/ for test: syncobj_wait results: parsing output: 59/ for test: kms_psr results: parsing output: 60/ for test: i915_suspend results: parsing output: 61/ for test: kms_cursor_crc results: parsing output: 62/ for test: kms_cursor_crc results: parsing output: 63/ for test: syncobj_timeline results: parsing output: 64/ for test: kms_cursor_legacy results: parsing output: 65/ for test: gem_exec_nop results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: sw_sync results: parsing output: 68/ for test: kms_flip_event_leak results: parsing output: 69/ for test: kms_properties results: parsing output: 70/ for test: i915_getparams_basic results: parsing output: 71/ for test: syncobj_timeline results: parsing output: 72/ for test: i915_pm_rps results: parsing output: 73/ for test: kms_plane_lowres results: parsing output: 74/ for test: gem_userptr_blits results: parsing output: 75/ for test: kms_invalid_mode results: parsing output: 76/ for test: kms_flip_scaled_crc results: parsing output: 77/ for test: syncobj_eventfd results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_mmap_offset results: parsing output: 80/ for test: kms_addfb_basic results: parsing output: 81/ for test: api_intel_bb results: parsing output: 82/ for test: gem_mmap_wc results: parsing output: 83/ for test: kms_prime results: parsing output: 84/ for test: syncobj_wait results: parsing output: 85/ for test: kms_lease results: parsing output: 86/ for test: kms_busy results: parsing output: 87/ for test: kms_flip results: parsing output: 88/ for test: kms_plane results: parsing output: 89/ for test: prime_vgem results: parsing output: 90/ for test: kms_atomic_transition results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: gem_render_copy results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: gem_eio results: parsing output: 95/ for test: gem_pxp results: parsing output: 96/ for test: syncobj_wait results: parsing output: 97/ for test: syncobj_wait results: parsing output: 98/ for test: syncobj_wait results: parsing output: 99/ for test: syncobj_wait results: parsing output: 100/ for test: kms_chamelium_hpd results: parsing output: 101/ for test: kms_force_connector_basic results: parsing output: 102/ for test: gem_pwrite results: parsing output: 103/ for test: kms_psr results: parsing output: 104/ for test: syncobj_timeline results: parsing output: 105/ for test: kms_plane_scaling results: parsing output: 106/ for test: gem_exec_create results: parsing output: 107/ for test: core_getversion results: parsing output: 108/ for test: gem_mmap_wc results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_flip results: parsing output: 111/ for test: kms_big_fb results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: perf_pmu results: parsing output: 114/ for test: gem_mmap_gtt results: parsing output: 115/ for test: kms_flip results: parsing output: 116/ for test: sw_sync results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_exec_reloc results: parsing output: 119/ for test: syncobj_wait results: parsing output: 120/ for test: i915_drm_fdinfo results: parsing output: 121/ for test: kms_cursor_edge_walk results: parsing output: 122/ for test: kms_atomic_interruptible results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_vrr results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_psr results: parsing output: 128/ for test: gem_mmap_gtt results: parsing output: 129/ for test: prime_mmap results: parsing output: 130/ for test: kms_big_fb results: parsing output: 131/ for test: prime_mmap results: parsing output: 132/ for test: gem_lmem_swapping Done.