[58.517410] Initializing watchdogs [58.517454] /dev/watchdog0 [58.531507] [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] [58.535807] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.537797] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.540000] [001/133] (960s left) syncobj_basic (bad-create-flags) [58.596579] Starting subtest: bad-create-flags [58.597628] Subtest bad-create-flags: SUCCESS (0.000s) [58.714497] [002/133] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [63.717907] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [63.719180] Starting dynamic subtest: pipe-A-eDP-1 [70.591788] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.861s) [70.598452] Starting dynamic subtest: pipe-B-eDP-1 [77.460835] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.863s) [77.461778] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.727s) [78.338192] [003/133] (940s left) gem_ccs (block-copy-compressed) [78.402421] Starting subtest: block-copy-compressed [78.404449] Subtest block-copy-compressed: SKIP (0.000s) [78.531398] [004/133] (940s left) kms_sequence (get-forked-busy) [78.610269] Starting subtest: get-forked-busy [78.611155] Starting dynamic subtest: pipe-A-eDP-1 [80.545375] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s) [80.552200] Starting dynamic subtest: pipe-B-eDP-1 [83.117376] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.571s) [83.123804] Starting dynamic subtest: pipe-C-eDP-1 [85.733787] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s) [85.743917] Starting dynamic subtest: pipe-D-eDP-1 [88.354281] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s) [88.355215] Subtest get-forked-busy: SUCCESS (9.740s) [89.245196] [005/133] (929s left) sysfs_preempt_timeout (timeout) [89.304554] Starting subtest: timeout [89.305579] Starting dynamic subtest: vecs0 [98.920452] Dynamic subtest vecs0: SUCCESS (9.610s) [98.929178] Starting dynamic subtest: ccs0 [100.268357] Dynamic subtest ccs0: SUCCESS (1.347s) [100.277769] Starting dynamic subtest: vcs0 [109.942902] Dynamic subtest vcs0: SUCCESS (9.671s) [109.951777] Starting dynamic subtest: bcs0 [111.340393] Dynamic subtest bcs0: SUCCESS (1.398s) [111.348760] Starting dynamic subtest: rcs0 [112.620830] Dynamic subtest rcs0: SUCCESS (1.280s) [112.628930] Starting dynamic subtest: vcs1 [121.893108] Dynamic subtest vcs1: SUCCESS (9.268s) [121.894697] Subtest timeout: SUCCESS (32.581s) [121.983346] [006/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [122.069662] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [122.071547] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [122.202171] [007/133] (897s left) gem_ctx_persistence (legacy-engines-queued) [122.256949] Starting subtest: legacy-engines-queued [122.257918] Starting dynamic subtest: render [122.366929] Dynamic subtest render: SUCCESS (0.109s) [122.375531] Starting dynamic subtest: bsd1 [123.891974] Dynamic subtest bsd1: SUCCESS (1.521s) [123.901429] Starting dynamic subtest: bsd2 [125.876948] Dynamic subtest bsd2: SUCCESS (1.983s) [125.891565] Starting dynamic subtest: blt [125.978872] Dynamic subtest blt: SUCCESS (0.101s) [125.987111] Starting dynamic subtest: vebox [127.859964] Dynamic subtest vebox: SUCCESS (1.877s) [127.861454] Subtest legacy-engines-queued: SUCCESS (5.600s) [127.949411] [008/133] (891s left) drm_read (short-buffer-block) [128.118659] Starting subtest: short-buffer-block [128.120066] Subtest short-buffer-block: SUCCESS (0.000s) [128.278494] [009/133] (890s left) gem_render_copy_redux (normal) [128.341410] Starting subtest: normal [128.626767] Subtest normal: SUCCESS (0.286s) [128.779598] [010/133] (890s left) kms_big_fb (y-tiled-32bpp-rotate-90) [128.878959] Starting subtest: y-tiled-32bpp-rotate-90 [128.880913] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [129.008160] [011/133] (890s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [129.102102] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [136.416163] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.315s) [136.569807] [012/133] (882s left) gem_exec_suspend (basic) [136.620777] Starting subtest: basic [136.621762] Starting dynamic subtest: smem [137.942456] Dynamic subtest smem: SUCCESS (1.319s) [137.943711] Subtest basic: SUCCESS (1.320s) [138.138772] [013/133] (881s left) kms_hdmi_inject (inject-audio) [138.492208] Starting subtest: inject-audio [138.764620] Subtest inject-audio: SUCCESS (0.274s) [139.344304] [014/133] (880s left) kms_cursor_crc (cursor-sliding-32x10) [139.498328] Starting subtest: cursor-sliding-32x10 [139.541045] Subtest cursor-sliding-32x10: SKIP (0.040s) [139.873220] [015/133] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [139.970675] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [146.379151] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.410s) [146.541042] [016/133] (872s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [146.641712] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [146.643434] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [146.767293] [017/133] (872s left) gem_render_copy (y-tiled-ccs-to-linear) [146.830128] Starting subtest: y-tiled-ccs-to-linear [146.831826] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [147.025461] [018/133] (872s left) kms_big_fb (4-tiled-16bpp-rotate-90) [147.125770] Starting subtest: 4-tiled-16bpp-rotate-90 [147.146190] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s) [147.297310] [019/133] (872s left) syncobj_timeline (transfer-timeline-point) [147.355791] Starting subtest: transfer-timeline-point [147.356721] Subtest transfer-timeline-point: SUCCESS (0.001s) [147.475270] [020/133] (872s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [147.525137] Starting subtest: invalid-multi-wait-unsubmitted-submitted [147.526066] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [147.644210] [021/133] (871s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [147.744235] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [147.746070] Starting dynamic subtest: pipe-A-eDP-1 [147.755069] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [147.761536] Starting dynamic subtest: pipe-B-eDP-1 [147.770364] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [147.776423] Starting dynamic subtest: pipe-C-eDP-1 [147.785361] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [147.791130] Starting dynamic subtest: pipe-D-eDP-1 [147.799953] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [147.801559] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.010s) [150.001921] [022/133] (869s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [152.026053] Starting subtest: dpms-mode-unset-non-lpsp [153.188130] Subtest dpms-mode-unset-non-lpsp: SKIP (1.160s) [153.581962] [023/133] (866s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [153.685625] Starting subtest: psr-rgb565-draw-mmap-wc [160.270554] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.585s) [160.400035] [024/133] (859s left) kms_chamelium_edid (vga-edid-read) [160.770272] Subtest vga-edid-read: SKIP (0.000s) [161.560027] [025/133] (858s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [161.620792] Starting subtest: yf-tiled-to-vebox-y-tiled [161.622765] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [161.815953] [026/133] (857s left) kms_flip (dpms-off-confusion) [161.912805] Starting subtest: dpms-off-confusion [161.915000] Starting dynamic subtest: A-eDP1 [170.563885] Dynamic subtest A-eDP1: SUCCESS (8.648s) [170.571752] Starting dynamic subtest: B-eDP1 [179.256430] Dynamic subtest B-eDP1: SUCCESS (8.691s) [179.265032] Starting dynamic subtest: C-eDP1 [187.943150] Dynamic subtest C-eDP1: SUCCESS (8.686s) [187.950859] Starting dynamic subtest: D-eDP1 [196.645181] Dynamic subtest D-eDP1: SUCCESS (8.700s) [196.649157] Subtest dpms-off-confusion: SUCCESS (34.735s) [197.890104] [027/133] (821s left) gem_exec_big (single) [197.946872] Starting subtest: single [200.307900] Subtest single: SUCCESS (2.358s) [200.549079] [028/133] (819s left) gem_exec_flush (basic-wb-ro-default) [200.660498] Starting subtest: basic-wb-ro-default [206.115931] Subtest basic-wb-ro-default: SUCCESS (5.455s) [206.320460] [029/133] (813s left) kms_async_flips (async-flip-with-page-flip-events-linear) [206.417957] Starting subtest: async-flip-with-page-flip-events-linear [206.804265] Starting dynamic subtest: pipe-A-eDP-1 [209.539792] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.733s) [209.900148] Starting dynamic subtest: pipe-B-eDP-1 [212.632323] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.735s) [212.990695] Starting dynamic subtest: pipe-C-eDP-1 [215.728278] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.741s) [216.087381] Starting dynamic subtest: pipe-D-eDP-1 [218.822962] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.739s) [218.824339] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.403s) [219.989285] [030/133] (799s left) kms_plane_scaling (planes-downscale-factor-0-75) [220.077425] Starting subtest: planes-downscale-factor-0-75 [220.078399] Starting dynamic subtest: pipe-A [220.095560] Dynamic subtest pipe-A: SKIP (0.016s) [220.102559] Starting dynamic subtest: pipe-B [220.124152] Dynamic subtest pipe-B: SKIP (0.029s) [220.131224] Starting dynamic subtest: pipe-C [220.153704] Dynamic subtest pipe-C: SKIP (0.029s) [220.160367] Starting dynamic subtest: pipe-D [220.182656] Dynamic subtest pipe-D: SKIP (0.029s) [220.184355] Subtest planes-downscale-factor-0-75: SKIP (0.105s) [220.315443] [031/133] (799s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [220.397350] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [220.398977] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [220.506341] [032/133] (799s left) kms_properties (colorop-properties-legacy) [220.584462] Starting subtest: colorop-properties-legacy [220.585386] Starting dynamic subtest: pipe-A-eDP-1 [220.959319] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.374s) [220.966182] Starting dynamic subtest: pipe-B-eDP-1 [222.010493] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.051s) [222.017683] Starting dynamic subtest: pipe-C-eDP-1 [223.117645] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s) [223.125560] Starting dynamic subtest: pipe-D-eDP-1 [224.203408] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.085s) [224.204238] Subtest colorop-properties-legacy: SUCCESS (3.621s) [225.088935] [033/133] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [225.181197] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [225.182863] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [225.298399] [034/133] (794s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [225.388965] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [225.389929] Starting dynamic subtest: pipe-A-eDP-1 [225.397871] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [225.405340] Starting dynamic subtest: pipe-B-eDP-1 [225.413208] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [225.420208] Starting dynamic subtest: pipe-C-eDP-1 [225.427881] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [225.434242] Starting dynamic subtest: pipe-D-eDP-1 [225.441695] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [225.442563] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [227.695301] [035/133] (792s left) gem_wait (wait) [227.760664] Starting subtest: wait [227.761698] Starting dynamic subtest: all-engines [228.883970] Dynamic subtest all-engines: SUCCESS (1.122s) [228.897165] Starting dynamic subtest: rcs0 [229.929909] Dynamic subtest rcs0: SUCCESS (1.044s) [229.941569] Starting dynamic subtest: bcs0 [230.974546] Dynamic subtest bcs0: SUCCESS (1.043s) [230.988191] Starting dynamic subtest: vcs0 [232.019851] Dynamic subtest vcs0: SUCCESS (1.043s) [232.029472] Starting dynamic subtest: vcs1 [233.064313] Dynamic subtest vcs1: SUCCESS (1.043s) [233.074669] Starting dynamic subtest: vecs0 [234.108996] Dynamic subtest vecs0: SUCCESS (1.043s) [234.119494] Starting dynamic subtest: ccs0 [235.156970] Dynamic subtest ccs0: SUCCESS (1.045s) [235.158265] Subtest wait: SUCCESS (7.397s) [235.372503] [036/133] (784s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [235.470676] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [235.472398] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [235.581270] [037/133] (784s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [235.672550] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [236.685543] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.013s) [236.843447] [038/133] (783s left) gem_exec_reloc (basic-concurrent0) [236.914923] Subtest basic-concurrent0: SKIP (0.000s) [236.993365] [039/133] (783s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [237.085764] Starting subtest: yf-tiled-32bpp-rotate-180 [237.087786] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [237.213788] [040/133] (782s left) kms_lease (cursor-implicit-plane) [237.324162] Starting subtest: cursor-implicit-plane [237.325138] Starting dynamic subtest: pipe-A-eDP-1 [237.782791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s) [237.790811] Starting dynamic subtest: pipe-B-eDP-1 [238.871072] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.085s) [238.878152] Starting dynamic subtest: pipe-C-eDP-1 [239.939683] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.066s) [239.946916] Starting dynamic subtest: pipe-D-eDP-1 [241.058250] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.118s) [241.059055] Subtest cursor-implicit-plane: SUCCESS (3.735s) [241.887387] [041/133] (778s left) gem_exec_schedule (u-semaphore-resolve) [241.969430] Starting subtest: u-semaphore-resolve [242.003798] Subtest u-semaphore-resolve: SUCCESS (0.035s) [242.356300] [042/133] (777s left) gem_exec_whisper (basic-fds-priority) [242.431568] Starting subtest: basic-fds-priority [266.340996] Subtest basic-fds-priority: SUCCESS (23.900s) [266.532974] [043/133] (753s left) i915_query (query-topology-known-pci-ids) [266.598512] Starting subtest: query-topology-known-pci-ids [266.600271] Subtest query-topology-known-pci-ids: SKIP (0.000s) [266.737183] [044/133] (753s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [266.843670] Starting subtest: yf-tiled-64bpp-rotate-90 [266.845468] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [266.978012] [045/133] (753s left) perf_pmu (idle) [267.017066] Starting subtest: idle [267.018078] Starting dynamic subtest: rcs0 [267.591576] Dynamic subtest rcs0: SUCCESS (0.571s) [267.600917] Starting dynamic subtest: bcs0 [268.118703] Dynamic subtest bcs0: SUCCESS (0.524s) [268.128670] Starting dynamic subtest: vcs0 [268.644847] Dynamic subtest vcs0: SUCCESS (0.523s) [268.655679] Starting dynamic subtest: vcs1 [269.171889] Dynamic subtest vcs1: SUCCESS (0.525s) [269.182576] Starting dynamic subtest: vecs0 [269.694688] Dynamic subtest vecs0: SUCCESS (0.520s) [269.705098] Starting dynamic subtest: ccs0 [270.210920] Dynamic subtest ccs0: SUCCESS (0.513s) [270.212563] Subtest idle: SUCCESS (3.192s) [270.343325] [046/133] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [270.450825] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [270.452673] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [270.576634] [047/133] (749s left) gem_exec_flush (basic-uc-pro-default) [270.638332] Starting subtest: basic-uc-pro-default [276.092476] Subtest basic-uc-pro-default: SUCCESS (5.454s) [276.295640] [048/133] (744s left) gem_basic (bad-close) [276.345515] Starting subtest: bad-close [276.347407] Subtest bad-close: SUCCESS (0.000s) [276.476062] [049/133] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [276.577889] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [276.579540] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [276.692938] [050/133] (743s left) kms_plane (pixel-format) [276.788925] Starting subtest: pixel-format [276.819771] Starting dynamic subtest: pipe-A-plane-0 [281.564106] Dynamic subtest pipe-A-plane-0: SUCCESS (4.744s) [281.572100] Starting dynamic subtest: pipe-A-plane-3 [283.786363] Dynamic subtest pipe-A-plane-3: SUCCESS (2.221s) [283.793952] Starting dynamic subtest: pipe-A-plane-5 [283.997490] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s) [285.131542] Starting dynamic subtest: pipe-B-plane-0 [289.724546] Dynamic subtest pipe-B-plane-0: SUCCESS (4.600s) [289.733554] Starting dynamic subtest: pipe-B-plane-3 [291.891256] Dynamic subtest pipe-B-plane-3: SUCCESS (2.164s) [291.901059] Starting dynamic subtest: pipe-B-plane-5 [292.091219] Dynamic subtest pipe-B-plane-5: SUCCESS (0.199s) [292.398458] Subtest pixel-format: SUCCESS (15.608s) [293.294597] [051/133] (727s left) kms_psr (fbc-psr2-no-drrs) [293.388508] Starting subtest: fbc-psr2-no-drrs [293.389584] Starting dynamic subtest: eDP-1 [293.391384] Dynamic subtest eDP-1: SKIP (0.000s) [293.393134] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [293.479967] [052/133] (727s left) gem_mmap (bad-size) [293.535967] Subtest bad-size: SKIP (0.000s) [293.608295] [053/133] (727s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [293.707469] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [293.709281] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [293.822202] [054/133] (726s left) api_intel_bb (crc32) [293.882077] Starting subtest: crc32 [293.883073] Starting dynamic subtest: rcs0-smem0 [294.180743] Dynamic subtest rcs0-smem0: SUCCESS (0.296s) [294.191340] Starting dynamic subtest: bcs0-smem0 [294.516622] Dynamic subtest bcs0-smem0: SUCCESS (0.334s) [294.526687] Starting dynamic subtest: vcs0-smem0 [294.932808] Dynamic subtest vcs0-smem0: SUCCESS (0.413s) [294.944886] Starting dynamic subtest: vcs1-smem0 [295.342327] Dynamic subtest vcs1-smem0: SUCCESS (0.407s) [295.352072] Starting dynamic subtest: vecs0-smem0 [295.690185] Dynamic subtest vecs0-smem0: SUCCESS (0.344s) [295.701375] Starting dynamic subtest: ccs0-smem0 [296.009583] Dynamic subtest ccs0-smem0: SUCCESS (0.317s) [296.011066] Subtest crc32: SUCCESS (2.128s) [296.159908] [055/133] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [296.249367] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [296.251087] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [296.383473] [056/133] (724s left) kms_psr (psr2-cursor-render) [296.472133] Starting subtest: psr2-cursor-render [296.472949] Starting dynamic subtest: eDP-1 [298.205909] Dynamic subtest eDP-1: SUCCESS (1.733s) [298.206864] Subtest psr2-cursor-render: SUCCESS (1.734s) [299.095959] [057/133] (721s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [299.190142] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [299.202065] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s) [299.298155] [058/133] (721s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [299.385495] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [299.387701] Starting dynamic subtest: pipe-A-eDP-1 [299.799091] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s) [299.806946] Starting dynamic subtest: pipe-B-eDP-1 [301.213512] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.413s) [301.221306] Starting dynamic subtest: pipe-C-eDP-1 [302.594656] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s) [302.602532] Starting dynamic subtest: pipe-D-eDP-1 [303.986844] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.391s) [303.987733] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.592s) [305.183804] [059/133] (715s left) kms_dp_linktrain_fallback (dp-fallback) [305.283150] Starting subtest: dp-fallback [305.285503] Subtest dp-fallback: SKIP (0.000s) [305.374651] [060/133] (715s left) gem_readwrite (beyond-eob) [305.433981] Subtest beyond-EOB: SKIP (0.000s) [305.488852] [061/133] (715s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [305.589302] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [310.033401] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.444s) [311.191896] [062/133] (709s left) prime_vgem (basic-fence-read) [311.363438] Starting subtest: basic-fence-read [311.371253] Subtest basic-fence-read: SKIP (0.007s) [311.500168] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [311.501951] [063/133] (709s left) perf_pmu (interrupts) [311.536314] Starting subtest: interrupts [312.648798] Subtest interrupts: SUCCESS (1.110s) [312.797684] [064/133] (708s left) i915_pm_rpm (system-suspend-devices) [315.018053] Starting subtest: system-suspend-devices [322.813823] Subtest system-suspend-devices: SUCCESS (7.796s) [329.227934] [065/133] (697s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [329.331436] Starting subtest: flip-vs-dpms-on-nop-interruptible [329.334092] Starting dynamic subtest: A-eDP1 [331.247988] Dynamic subtest A-eDP1: SUCCESS (1.913s) [331.259256] Starting dynamic subtest: B-eDP1 [333.127376] Dynamic subtest B-eDP1: SUCCESS (1.876s) [333.139458] Starting dynamic subtest: C-eDP1 [334.927803] Dynamic subtest C-eDP1: SUCCESS (1.797s) [334.937553] Starting dynamic subtest: D-eDP1 [336.719331] Dynamic subtest D-eDP1: SUCCESS (1.790s) [336.721992] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.390s) [337.982982] [066/133] (689s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [338.071930] Starting subtest: crc-primary-basic-y-tiled-ccs [338.072859] Starting dynamic subtest: pipe-A-eDP-1 [338.081641] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [338.090896] Starting dynamic subtest: pipe-B-eDP-1 [338.099737] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [338.108312] Starting dynamic subtest: pipe-C-eDP-1 [338.116800] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [338.124951] Starting dynamic subtest: pipe-D-eDP-1 [338.133523] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [338.135230] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [340.280949] [067/133] (686s left) kms_color (ctm-0-75) [340.375685] Starting subtest: ctm-0-75 [340.376597] Starting dynamic subtest: pipe-A-eDP-1 [345.094599] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.719s) [345.103399] Starting dynamic subtest: pipe-B-eDP-1 [350.723058] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.628s) [350.731295] Starting dynamic subtest: pipe-C-eDP-1 [356.159035] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.434s) [356.167281] Starting dynamic subtest: pipe-D-eDP-1 [361.394139] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.235s) [361.395046] Subtest ctm-0-75: SUCCESS (21.018s) [362.281177] [068/133] (664s left) gem_mmap_offset (partial-mmap) [362.337471] Starting subtest: partial-mmap [362.338440] Starting dynamic subtest: smem0 [362.346052] Dynamic subtest smem0: SUCCESS (0.009s) [362.348803] Subtest partial-mmap: SUCCESS (0.011s) [362.499897] [069/133] (664s left) syncobj_timeline (device-signal-unordered) [362.557796] Starting subtest: device-signal-unordered [362.558748] Subtest device-signal-unordered: SUCCESS (0.000s) [362.692541] [070/133] (664s left) kms_pm_dc (dc6-psr) [363.794204] Starting subtest: dc6-psr [366.669220] Subtest dc6-psr: SUCCESS (2.875s) [367.490939] [071/133] (659s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [367.597787] Starting subtest: cursorB-vs-flipB-varying-size [367.599705] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [367.763863] [072/133] (659s left) kms_addfb_basic (no-handle) [367.817200] Starting subtest: no-handle [367.818085] Subtest no-handle: SUCCESS (0.000s) [367.975986] [073/133] (659s left) gem_pxp (create-regular-buffer) [368.090178] Starting subtest: create-regular-buffer [368.091336] Subtest create-regular-buffer: SUCCESS (0.000s) [368.214408] [074/133] (659s left) kms_flip (2x-dpms-vs-vblank-race) [368.303060] Starting subtest: 2x-dpms-vs-vblank-race [368.314992] Subtest 2x-dpms-vs-vblank-race: SKIP (0.012s) [368.415314] [075/133] (658s left) kms_psr (psr-dpms) [368.515462] Starting subtest: psr-dpms [368.516485] Starting dynamic subtest: eDP-1 [371.430441] Dynamic subtest eDP-1: SUCCESS (2.915s) [371.431420] Subtest psr-dpms: SUCCESS (2.917s) [372.278889] [076/133] (655s left) gem_lmem_swapping (massive-random) [372.312866] Subtest massive-random: SKIP (0.000s) [372.350981] [077/133] (655s left) gen9_exec_parse (bb-secure) [372.405860] Subtest bb-secure: SKIP (0.000s) [372.498969] [078/133] (654s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [372.593819] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [372.595585] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [372.732976] [079/133] (654s left) i915_suspend (fence-restore-untiled) [372.787582] Starting subtest: fence-restore-untiled [372.789444] Subtest fence-restore-untiled: SKIP (0.000s) [372.894152] [080/133] (654s left) syncobj_wait (wait-delayed-signal) [372.946335] Starting subtest: wait-delayed-signal [373.051466] Subtest wait-delayed-signal: SUCCESS (0.103s) [373.143616] [081/133] (654s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [373.239350] Starting subtest: bad-pixel-format-yf-tiled-ccs [373.240244] Starting dynamic subtest: pipe-A-eDP-1 [373.248960] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [373.257468] Starting dynamic subtest: pipe-B-eDP-1 [373.266193] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [373.274940] Starting dynamic subtest: pipe-C-eDP-1 [373.283446] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [373.291782] Starting dynamic subtest: pipe-D-eDP-1 [373.300493] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [373.302120] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s) [375.480665] [082/133] (652s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [375.572785] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [375.574654] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [375.702728] [083/133] (651s left) kms_chamelium_hpd (dp-hpd-fast) [376.092746] Subtest dp-hpd-fast: SKIP (0.000s) [376.950617] [084/133] (650s left) gem_exec_balancer (bonded-false-hang) [377.208042] Starting subtest: bonded-false-hang [377.210785] Subtest bonded-false-hang: SKIP (0.000s) [377.348109] [085/133] (650s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [377.440375] Starting subtest: crc-primary-suspend-yf-tiled-ccs [377.441259] Starting dynamic subtest: pipe-A-eDP-1 [377.444536] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [377.457437] Starting dynamic subtest: pipe-B-eDP-1 [377.460692] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [377.470228] Starting dynamic subtest: pipe-C-eDP-1 [377.476033] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [377.493959] Starting dynamic subtest: pipe-D-eDP-1 [377.498498] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [377.500246] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s) [379.678445] [086/133] (648s left) gem_exec_fence (syncobj-timeline-invalid-flags) [380.262426] Starting subtest: syncobj-timeline-invalid-flags [380.264063] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [381.995455] [087/133] (645s left) kms_plane_cursor (overlay) [382.087012] Starting subtest: overlay [382.088633] Starting dynamic subtest: pipe-A-eDP-1-size-64 [384.529865] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.442s) [384.599509] Starting dynamic subtest: pipe-A-eDP-1-size-128 [387.030588] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.449s) [387.098899] Starting dynamic subtest: pipe-A-eDP-1-size-256 [389.632052] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.548s) [389.979439] Starting dynamic subtest: pipe-B-eDP-1-size-64 [393.175796] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.204s) [393.237857] Starting dynamic subtest: pipe-B-eDP-1-size-128 [395.776747] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s) [395.838972] Starting dynamic subtest: pipe-B-eDP-1-size-256 [398.254994] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.426s) [398.605575] Starting dynamic subtest: pipe-C-eDP-1-size-64 [401.415989] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.819s) [401.455558] Starting dynamic subtest: pipe-C-eDP-1-size-128 [403.482708] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.036s) [403.529896] Starting dynamic subtest: pipe-C-eDP-1-size-256 [405.693901] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.179s) [406.030969] Starting dynamic subtest: pipe-D-eDP-1-size-64 [408.864194] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.841s) [408.903299] Starting dynamic subtest: pipe-D-eDP-1-size-128 [410.954068] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.058s) [410.993180] Starting dynamic subtest: pipe-D-eDP-1-size-256 [413.064655] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.080s) [413.389535] Subtest overlay: SUCCESS (31.300s) [414.277591] [088/133] (613s left) gem_ctx_param (basic-default) [414.327551] Starting subtest: basic-default [414.328470] Subtest basic-default: SUCCESS (0.000s) [414.412635] [089/133] (613s left) api_intel_allocator (two-level-inception-interruptible) [414.462713] Starting subtest: two-level-inception-interruptible [419.870476] Subtest two-level-inception-interruptible: SUCCESS (5.406s) [420.021361] [090/133] (607s left) kms_dsc (dsc-with-bpc-formats) [420.116308] Starting subtest: dsc-with-bpc-formats [420.159398] Subtest dsc-with-bpc-formats: SKIP (0.003s) [420.212415] [091/133] (607s left) kms_cursor_crc (cursor-alpha-opaque) [420.308757] Starting subtest: cursor-alpha-opaque [420.309595] Starting dynamic subtest: pipe-A-eDP-1 [420.946886] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.642s) [420.956381] Starting dynamic subtest: pipe-D-eDP-1 [422.213638] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.265s) [422.214562] Subtest cursor-alpha-opaque: SUCCESS (1.911s) [423.089654] [092/133] (604s left) syncobj_timeline (multi-wait-all-signaled) [423.153407] Starting subtest: multi-wait-all-signaled [423.154440] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [423.292542] [093/133] (604s left) i915_drm_fdinfo (isolation) [423.339376] Starting subtest: isolation [423.340243] Starting dynamic subtest: rcs0 [423.376140] Dynamic subtest rcs0: SKIP (0.036s) [423.385636] Starting dynamic subtest: bcs0 [423.387184] Dynamic subtest bcs0: SKIP (0.001s) [423.394931] Starting dynamic subtest: vcs0 [423.396517] Dynamic subtest vcs0: SKIP (0.000s) [423.404764] Starting dynamic subtest: vcs1 [423.406436] Dynamic subtest vcs1: SKIP (0.000s) [423.414312] Starting dynamic subtest: vecs0 [423.415837] Dynamic subtest vecs0: SKIP (0.000s) [423.423892] Starting dynamic subtest: ccs0 [423.425540] Dynamic subtest ccs0: SKIP (0.000s) [423.427189] Subtest isolation: SKIP (0.044s) [423.469372] [094/133] (604s left) kms_flip_scaled_crc (flip-p016-linear-to-p016-linear-reflect-x) [423.552485] Starting subtest: flip-P016-linear-to-P016-linear-reflect-x [423.553444] Starting dynamic subtest: pipe-A-default-mode [424.680251] Dynamic subtest pipe-A-default-mode: SKIP (1.126s) [424.682062] Subtest flip-P016-linear-to-P016-linear-reflect-x: SKIP (1.128s) [424.847827] [095/133] (603s left) gem_ctx_isolation (preservation-s3) [424.897931] Starting subtest: preservation-S3 [424.898848] Starting dynamic subtest: rcs0 [441.743277] Dynamic subtest rcs0: SUCCESS (1.746s) [441.758678] Starting dynamic subtest: bcs0 [458.739698] Dynamic subtest bcs0: SUCCESS (1.701s) [458.749525] Starting dynamic subtest: vcs0 [475.735399] Dynamic subtest vcs0: SUCCESS (3.014s) [475.745261] Starting dynamic subtest: vcs1 [493.746946] Dynamic subtest vcs1: SUCCESS (5.002s) [493.756530] Starting dynamic subtest: vecs0 [511.747555] Dynamic subtest vecs0: SUCCESS (5.016s) [511.756803] Starting dynamic subtest: ccs0 [529.737442] Dynamic subtest ccs0: SUCCESS (3.164s) [529.738738] Subtest preservation-S3: SUCCESS (19.650s) [536.021460] [096/133] (498s left) gem_eio (reset-stress) [536.287446] Starting subtest: reset-stress [536.288742] Starting dynamic subtest: render [541.908996] Dynamic subtest render: SUCCESS (5.515s) [541.918482] Starting dynamic subtest: bsd1 [559.617596] Dynamic subtest bsd1: SUCCESS (17.605s) [559.633339] Starting dynamic subtest: bsd2 [577.595025] Dynamic subtest bsd2: SUCCESS (17.966s) [577.604253] Starting dynamic subtest: blt [577.606250] Dynamic subtest blt: SKIP (0.000s) [577.619718] Starting dynamic subtest: vebox [595.716242] Dynamic subtest vebox: SUCCESS (18.114s) [595.717608] Subtest reset-stress: SUCCESS (59.206s) [597.140812] [097/133] (436s left) gem_softpin (evict-snoop-interruptible) [597.194632] Starting subtest: evict-snoop-interruptible [597.198275] Subtest evict-snoop-interruptible: SKIP (0.000s) [597.342379] [098/133] (436s left) i915_module_load (reload-no-display) [597.377608] Starting subtest: reload-no-display [603.336888] Subtest reload-no-display: SUCCESS (5.956s) [603.359039] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [603.359774] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [603.361789] [099/133] (430s left) kms_flip (2x-flip-vs-modeset) [606.235406] Starting subtest: 2x-flip-vs-modeset [606.246223] Subtest 2x-flip-vs-modeset: SKIP (0.011s) [606.354675] [FACT kms_flip (2x-flip-vs-modeset)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [606.356185] [FACT kms_flip (2x-flip-vs-modeset)] new: kernel.kmod_is_loaded.i915: true [606.358904] [100/133] (427s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [606.451641] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [606.452742] Starting dynamic subtest: pipe-A-default-mode [606.740190] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [606.742995] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.287s) [607.578761] [101/133] (426s left) kms_content_protection (type1) [607.733380] Starting subtest: type1 [607.735376] Subtest type1: SKIP (0.000s) [607.894521] [102/133] (426s left) kms_big_fb (4-tiled-16bpp-rotate-180) [607.987271] Starting subtest: 4-tiled-16bpp-rotate-180 [609.254683] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.267s) [609.409057] [103/133] (424s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [609.505341] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [609.507944] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [609.614381] [104/133] (424s left) gem_ppgtt (flink-and-close-vma-leak) [609.667901] Starting subtest: flink-and-close-vma-leak [609.709940] Subtest flink-and-close-vma-leak: SUCCESS (0.043s) [609.864432] [105/133] (424s left) syncobj_wait (signal) [609.920978] Starting subtest: signal [609.922473] Subtest signal: SUCCESS (0.000s) [610.044408] [106/133] (424s left) kms_cursor_crc (cursor-rapid-movement-128x128) [610.238090] Starting subtest: cursor-rapid-movement-128x128 [610.240150] Starting dynamic subtest: pipe-A-eDP-1 [610.770923] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s) [610.804969] Starting dynamic subtest: pipe-D-eDP-1 [611.960555] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.167s) [611.961590] Subtest cursor-rapid-movement-128x128: SUCCESS (1.724s) [612.858271] [107/133] (421s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [617.895929] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [617.897090] Starting dynamic subtest: pipe-A-eDP-1 [618.692726] Dynamic subtest pipe-A-eDP-1: SKIP (0.796s) [618.701456] Starting dynamic subtest: pipe-B-eDP-1 [619.824712] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s) [619.826605] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.927s) [621.037171] [108/133] (413s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [621.143204] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [627.627478] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.480s) [627.797635] [109/133] (406s left) kms_vblank (query-forked-busy) [627.894679] Starting subtest: query-forked-busy [627.895839] Starting dynamic subtest: pipe-A-eDP-1 [629.769701] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.872s) [629.781949] Starting dynamic subtest: pipe-D-eDP-1 [632.308055] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s) [632.309523] Subtest query-forked-busy: SUCCESS (4.410s) [633.149643] [110/133] (401s left) syncobj_timeline (invalid-transfer-non-existent-point) [633.201873] Starting subtest: invalid-transfer-non-existent-point [633.202702] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [633.320335] [111/133] (401s left) kms_big_fb (x-tiled-16bpp-rotate-0) [633.409300] Starting subtest: x-tiled-16bpp-rotate-0 [634.787992] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.380s) [634.956202] [112/133] (399s left) kms_psr (fbc-psr-primary-blt) [635.058225] Starting subtest: fbc-psr-primary-blt [635.059510] Starting dynamic subtest: eDP-1 [635.061961] Dynamic subtest eDP-1: SKIP (0.000s) [635.063904] Subtest fbc-psr-primary-blt: SKIP (0.001s) [635.148932] [113/133] (399s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [635.205402] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [635.311522] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s) [635.404637] [114/133] (399s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [635.493337] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [635.495254] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [635.614026] [115/133] (399s left) gem_exec_reloc (basic-cpu-active) [635.673407] Subtest basic-cpu-active: SKIP (0.000s) [635.757867] [116/133] (399s left) perf (rc6-disable) [635.898839] Starting subtest: rc6-disable [636.084447] Subtest rc6-disable: SUCCESS (0.185s) [636.127080] [117/133] (398s left) gem_ctx_shared (q-independent) [636.199543] Starting subtest: Q-independent [636.201292] Starting dynamic subtest: rcs0 [636.269463] Dynamic subtest rcs0: SUCCESS (0.069s) [636.279308] Starting dynamic subtest: vcs0 [636.309251] Dynamic subtest vcs0: SUCCESS (0.040s) [636.318186] Starting dynamic subtest: vcs1 [636.343312] Dynamic subtest vcs1: SUCCESS (0.033s) [636.352014] Starting dynamic subtest: vecs0 [636.378583] Dynamic subtest vecs0: SUCCESS (0.035s) [636.387400] Starting dynamic subtest: ccs0 [636.417527] Dynamic subtest ccs0: SUCCESS (0.038s) [636.419084] Subtest Q-independent: SUCCESS (0.219s) [638.236023] [118/133] (396s left) perf (non-zero-reason) [638.342120] Starting subtest: non-zero-reason [638.343544] Starting dynamic subtest: 0-rcs0 [643.706084] Dynamic subtest 0-rcs0: SUCCESS (5.363s) [643.716954] Starting dynamic subtest: 1-vcs1 [647.594537] Dynamic subtest 1-vcs1: SUCCESS (3.888s) [647.596535] Subtest non-zero-reason: SUCCESS (9.254s) [647.641571] [119/133] (387s left) kms_psr (pr-dpms) [647.726545] Starting subtest: pr-dpms [647.729074] Subtest pr-dpms: SKIP (0.000s) [647.818967] [120/133] (387s left) kms_rotation_crc (primary-rotation-180) [647.911088] Starting subtest: primary-rotation-180 [655.061121] Subtest primary-rotation-180: SUCCESS (7.151s) [656.276016] [121/133] (378s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [656.375551] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [663.635354] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.261s) [663.789353] [122/133] (371s left) gem_create (create-size-update) [663.849017] Starting subtest: create-size-update [663.850203] Subtest create-size-update: SUCCESS (0.000s) [664.090598] [123/133] (370s left) prime_vgem (basic-fence-blt) [664.190393] Starting subtest: basic-fence-blt [664.294088] Subtest basic-fence-blt: SUCCESS (0.103s) [664.444496] [124/133] (370s left) kms_getfb (getfb2-into-addfb2) [664.529721] Starting subtest: getfb2-into-addfb2 [664.531007] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [664.637868] [125/133] (370s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [664.758965] Starting subtest: verify-pxp-execution-after-suspend-resume [671.880354] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.122s) [681.088266] [126/133] (363s left) syncobj_basic (bad-pad-fd-to-handle) [681.145408] Starting subtest: bad-pad-fd-to-handle [681.146677] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [681.303305] [127/133] (362s left) dmabuf_sync_file (export-before-signal) [681.347540] Starting subtest: export-before-signal [681.348893] Subtest export-before-signal: SUCCESS (0.001s) [681.423292] [128/133] (362s left) kms_flip (2x-flip-vs-panning-vs-hang) [681.515114] Starting subtest: 2x-flip-vs-panning-vs-hang [681.524642] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s) [681.623855] [129/133] (362s left) gem_softpin (allocator-nopin-reserve) [681.687299] Starting subtest: allocator-nopin-reserve [681.767406] Subtest allocator-nopin-reserve: SUCCESS (0.080s) [681.930048] [130/133] (362s left) kms_pipe_crc_basic (read-crc-frame-sequence) [682.028080] Starting subtest: read-crc-frame-sequence [682.029225] Starting dynamic subtest: pipe-A-eDP-1 [682.762870] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.734s) [682.774288] Starting dynamic subtest: pipe-B-eDP-1 [684.133166] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.368s) [684.144162] Starting dynamic subtest: pipe-C-eDP-1 [685.487332] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.351s) [685.496412] Starting dynamic subtest: pipe-D-eDP-1 [686.851107] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.362s) [686.852099] Subtest read-crc-frame-sequence: SUCCESS (4.824s) [687.691322] [131/133] (356s left) kms_frontbuffer_tracking (pipe-fbc-rte) [687.789642] Starting subtest: pipe-fbc-rte [687.792834] Starting dynamic subtest: pipe-B-eDP-1 [693.280512] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.491s) [693.285411] Subtest pipe-fbc-rte: SUCCESS (5.493s) [695.596058] [132/133] (348s left) kms_addfb_basic (too-wide) [695.699682] Starting subtest: too-wide [695.700858] Subtest too-wide: SUCCESS (0.000s) [695.803887] [133/133] (348s left) gem_exec_schedule (pi-shared-iova) [695.989315] Starting subtest: pi-shared-iova [695.990273] Starting dynamic subtest: rcs0 [696.078473] Dynamic subtest rcs0: SUCCESS (0.088s) [696.087431] Starting dynamic subtest: vcs0 [696.139266] Dynamic subtest vcs0: SUCCESS (0.060s) [696.151101] Starting dynamic subtest: vcs1 [696.194767] Dynamic subtest vcs1: SUCCESS (0.054s) [696.205734] Starting dynamic subtest: vecs0 [696.251018] Dynamic subtest vecs0: SUCCESS (0.057s) [696.260018] Starting dynamic subtest: ccs0 [696.307353] Dynamic subtest ccs0: SUCCESS (0.056s) [696.308602] Subtest pi-shared-iova: SUCCESS (0.319s) [698.199876] Closing watchdogs results: parsing output: 0/ for test: syncobj_basic results: parsing output: 1/ for test: kms_psr2_sf results: parsing output: 2/ for test: gem_ccs results: parsing output: 3/ for test: kms_sequence results: parsing output: 4/ for test: sysfs_preempt_timeout results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_ctx_persistence results: parsing output: 7/ for test: drm_read results: parsing output: 8/ for test: gem_render_copy_redux results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_exec_suspend results: parsing output: 12/ for test: kms_hdmi_inject results: parsing output: 13/ for test: kms_cursor_crc results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_render_copy results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: syncobj_timeline results: parsing output: 19/ for test: syncobj_wait results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: kms_pm_rpm results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_chamelium_edid results: parsing output: 24/ for test: gem_render_copy results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: gem_exec_big results: parsing output: 27/ for test: gem_exec_flush results: parsing output: 28/ for test: kms_async_flips results: parsing output: 29/ for test: kms_plane_scaling results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_properties results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_ccs results: parsing output: 34/ for test: gem_wait results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: gem_exec_reloc results: parsing output: 38/ for test: kms_big_fb results: parsing output: 39/ for test: kms_lease results: parsing output: 40/ for test: gem_exec_schedule results: parsing output: 41/ for test: gem_exec_whisper results: parsing output: 42/ for test: i915_query results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: perf_pmu results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_exec_flush results: parsing output: 47/ for test: gem_basic results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_plane results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: gem_mmap results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: api_intel_bb results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_psr results: parsing output: 56/ for test: kms_flip results: parsing output: 57/ for test: kms_ccs results: parsing output: 58/ for test: kms_dp_linktrain_fallback results: parsing output: 59/ for test: gem_readwrite results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: prime_vgem results: parsing output: 62/ for test: perf_pmu results: parsing output: 63/ for test: i915_pm_rpm results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_ccs results: parsing output: 66/ for test: kms_color results: parsing output: 67/ for test: gem_mmap_offset results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: kms_pm_dc results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: gem_pxp results: parsing output: 73/ for test: kms_flip results: parsing output: 74/ for test: kms_psr results: parsing output: 75/ for test: gem_lmem_swapping results: parsing output: 76/ for test: gen9_exec_parse results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: i915_suspend results: parsing output: 79/ for test: syncobj_wait results: parsing output: 80/ for test: kms_ccs results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_chamelium_hpd results: parsing output: 83/ for test: gem_exec_balancer results: parsing output: 84/ for test: kms_ccs results: parsing output: 85/ for test: gem_exec_fence results: parsing output: 86/ for test: kms_plane_cursor results: parsing output: 87/ for test: gem_ctx_param results: parsing output: 88/ for test: api_intel_allocator results: parsing output: 89/ for test: kms_dsc results: parsing output: 90/ for test: kms_cursor_crc results: parsing output: 91/ for test: syncobj_timeline results: parsing output: 92/ for test: i915_drm_fdinfo results: parsing output: 93/ for test: kms_flip_scaled_crc results: parsing output: 94/ for test: gem_ctx_isolation results: parsing output: 95/ for test: gem_eio results: parsing output: 96/ for test: gem_softpin results: parsing output: 97/ for test: i915_module_load results: parsing output: 98/ for test: kms_flip results: parsing output: 99/ for test: kms_flip_scaled_crc results: parsing output: 100/ for test: kms_content_protection results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: gem_ppgtt results: parsing output: 104/ for test: syncobj_wait results: parsing output: 105/ for test: kms_cursor_crc results: parsing output: 106/ for test: kms_psr2_sf results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_vblank results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: kms_psr results: parsing output: 112/ for test: syncobj_timeline results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: perf results: parsing output: 116/ for test: gem_ctx_shared results: parsing output: 117/ for test: perf results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: kms_rotation_crc results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: gem_create results: parsing output: 122/ for test: prime_vgem results: parsing output: 123/ for test: kms_getfb results: parsing output: 124/ for test: gem_pxp results: parsing output: 125/ for test: syncobj_basic results: parsing output: 126/ for test: dmabuf_sync_file results: parsing output: 127/ for test: kms_flip results: parsing output: 128/ for test: gem_softpin results: parsing output: 129/ for test: kms_pipe_crc_basic results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_addfb_basic results: parsing output: 132/ for test: gem_exec_schedule Done.