[58.534941] Initializing watchdogs
[58.534986]   /dev/watchdog0
[58.548321] [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.552713] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.555021] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.558361] [001/132] (960s left) kms_lease (lease-revoke)
[58.680279] Starting subtest: lease-revoke
[58.682965] Starting dynamic subtest: pipe-A-eDP-1
[58.715064] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.034s)
[58.724653] Starting dynamic subtest: pipe-B-eDP-1
[58.742439] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.029s)
[58.752133] Starting dynamic subtest: pipe-C-eDP-1
[58.770838] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[58.779022] Starting dynamic subtest: pipe-D-eDP-1
[58.796361] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.025s)
[58.798591] Subtest lease-revoke: SUCCESS (0.119s)
[58.912031] [002/132] (960s left) kms_pm_backlight (bad-brightness)
[59.005934] Starting subtest: bad-brightness
[59.092805] Starting dynamic subtest: eDP-1
[59.423468] Dynamic subtest eDP-1: SUCCESS (0.330s)
[59.425949] Subtest bad-brightness: SUCCESS (0.419s)
[60.224904] [003/132] (958s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[60.288853] Starting subtest: invalid-bsd2-flag-on-blt
[60.291366] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[60.389202] [004/132] (958s left) tools_test (tools_test)
[60.436371] Starting subtest: tools_test
[60.492601] Subtest tools_test: SUCCESS (0.071s)
[60.571210] [005/132] (958s left) gem_ctx_isolation (preservation)
[60.625326] Starting subtest: preservation
[60.627760] Starting dynamic subtest: rcs0
[60.759519] Dynamic subtest rcs0: SUCCESS (0.134s)
[60.770549] Starting dynamic subtest: bcs0
[60.884471] Dynamic subtest bcs0: SUCCESS (0.124s)
[60.894165] Starting dynamic subtest: vcs0
[61.038497] Dynamic subtest vcs0: SUCCESS (0.153s)
[61.046641] Starting dynamic subtest: vcs1
[63.013967] Dynamic subtest vcs1: SUCCESS (1.975s)
[63.024572] Starting dynamic subtest: vecs0
[64.973730] Dynamic subtest vecs0: SUCCESS (1.959s)
[64.981552] Starting dynamic subtest: ccs0
[67.126919] Dynamic subtest ccs0: SUCCESS (2.154s)
[67.129519] Subtest preservation: SUCCESS (6.502s)
[67.665946] [006/132] (951s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[67.793124] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[67.797526] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[67.965997] [007/132] (951s left) gem_render_copy (y-tiled-to-vebox-linear)
[68.077424] Starting subtest: y-tiled-to-vebox-linear
[68.082128] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[68.258807] [008/132] (951s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[68.366074] Starting subtest: y-tiled-64bpp-rotate-180
[68.370500] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[68.469711] [009/132] (950s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[68.559724] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[68.561740] Starting dynamic subtest: pipe-A-eDP-1
[69.031136] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[69.038305] Starting dynamic subtest: pipe-B-eDP-1
[70.411610] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.379s)
[70.421113] Starting dynamic subtest: pipe-C-eDP-1
[71.736838] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.325s)
[71.744101] Starting dynamic subtest: pipe-D-eDP-1
[73.061947] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[73.063789] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.476s)
[74.252281] [010/132] (945s left) kms_vblank (query-idle)
[74.347771] Starting subtest: query-idle
[74.350088] Starting dynamic subtest: pipe-A-eDP-1
[76.089608] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.740s)
[76.107022] Starting dynamic subtest: pipe-D-eDP-1
[78.494634] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.404s)
[78.496992] Subtest query-idle: SUCCESS (4.148s)
[79.318656] [011/132] (940s left) gem_render_copy (yf-tiled)
[79.373582] Starting subtest: yf-tiled
[79.378230] Subtest yf-tiled: SKIP (0.000s)
[79.555216] [012/132] (939s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[79.654336] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[79.658225] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[79.722318] [013/132] (939s left) kms_psr (pr-sprite-plane-move)
[79.806587] Starting subtest: pr-sprite-plane-move
[79.810950] Subtest pr-sprite-plane-move: SKIP (0.000s)
[79.880345] [014/132] (939s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[79.992895] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[84.416085] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.428s)
[85.614838] [015/132] (933s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[85.708266] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[85.712261] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[85.794823] [016/132] (933s left) gem_mmap_gtt (big-copy-xy)
[85.856288] Subtest big-copy-XY: SKIP (0.000s)
[85.920669] [017/132] (933s left) dmabuf_sync_file (export-multiwait)
[85.989613] Starting subtest: export-multiwait
[85.991572] Subtest export-multiwait: SUCCESS (0.001s)
[86.055842] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[86.059141] [018/132] (933s left) kms_flip (plain-flip-fb-recreate-interruptible)
[86.160805] Starting subtest: plain-flip-fb-recreate-interruptible
[86.163094] Starting dynamic subtest: A-eDP1
[95.001053] Dynamic subtest A-eDP1: SUCCESS (8.839s)
[95.010715] Starting dynamic subtest: B-eDP1
[103.832316] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[103.849972] Starting dynamic subtest: C-eDP1
[112.653322] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[112.666463] Starting dynamic subtest: D-eDP1
[121.483406] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[121.488480] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.328s)
[122.676367] [019/132] (897s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[122.772203] Starting subtest: basic-modeset-with-all-modifiers-formats
[123.149184] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[123.939275] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.791s)
[123.947867] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[123.961524] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.022s)
[123.968973] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[123.983408] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[123.991158] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[124.128218] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[124.137296] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[124.150547] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[124.157998] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[124.172610] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[124.181710] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[124.194735] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[124.201636] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[124.217038] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[124.224194] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[124.239155] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[124.246184] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[124.261771] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[124.268837] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[124.283910] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[124.291164] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[124.306087] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[124.313106] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[124.450388] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[124.457995] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[124.472673] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[124.480140] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[124.495058] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[124.503447] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[124.517117] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[124.523999] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[124.539420] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[124.546291] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[124.561474] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[124.568487] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[124.583946] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[124.590988] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[124.606536] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[124.613968] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[124.628223] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[124.635167] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[124.772592] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.144s)
[124.780051] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[124.794848] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[124.801947] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[124.817132] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[124.824279] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[124.839559] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[124.848606] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[124.861586] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[124.868293] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[124.883729] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[124.890238] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[124.906058] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[124.915520] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[124.928383] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[124.935643] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[124.950176] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[125.336787] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.566s)
[126.134121] [020/132] (893s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[126.191802] Starting subtest: single-wait-for-submit-available-signaled
[126.194138] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[126.287219] [021/132] (893s left) perf_pmu (semaphore-wait)
[126.329354] Starting subtest: semaphore-wait
[126.331614] Starting dynamic subtest: rcs0
[126.844057] Dynamic subtest rcs0: SUCCESS (0.513s)
[126.854848] Starting dynamic subtest: bcs0
[127.357497] Dynamic subtest bcs0: SUCCESS (0.511s)
[127.368919] Starting dynamic subtest: vcs0
[127.869303] Dynamic subtest vcs0: SUCCESS (0.512s)
[127.880444] Starting dynamic subtest: vcs1
[128.381513] Dynamic subtest vcs1: SUCCESS (0.510s)
[128.390760] Starting dynamic subtest: vecs0
[128.893676] Dynamic subtest vecs0: SUCCESS (0.511s)
[128.902678] Starting dynamic subtest: ccs0
[129.408669] Dynamic subtest ccs0: SUCCESS (0.513s)
[129.411724] Subtest semaphore-wait: SUCCESS (3.079s)
[130.928563] [022/132] (888s left) i915_query (query-topology-kernel-writes)
[130.980988] Starting subtest: query-topology-kernel-writes
[130.983482] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[131.077728] [023/132] (888s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[131.178784] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[131.183087] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[131.266944] [024/132] (888s left) kms_plane_alpha_blend (alpha-transparent-fb)
[131.353153] Starting subtest: alpha-transparent-fb
[131.657665] Starting dynamic subtest: pipe-A-eDP-1
[132.259071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[132.267303] Starting dynamic subtest: pipe-D-eDP-1
[133.563544] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.305s)
[133.566048] Subtest alpha-transparent-fb: SUCCESS (2.212s)
[134.385311] [025/132] (885s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[134.765333] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[135.575421] [026/132] (884s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[135.683450] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[135.687904] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[135.757711] [027/132] (884s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[135.857413] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[135.868239] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[135.940758] [028/132] (884s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[136.070844] Starting subtest: cursorA-vs-flipB-toggle
[136.075525] Subtest cursorA-vs-flipB-toggle: SKIP (0.002s)
[136.221139] [029/132] (883s left) gem_shrink (reclaim)
[136.290926] Starting subtest: reclaim
[138.763908] Subtest reclaim: SUCCESS (2.474s)
[138.918374] [030/132] (881s left) kms_getfb (getfb-handle-zero)
[139.007802] Starting subtest: getfb-handle-zero
[139.010103] Subtest getfb-handle-zero: SUCCESS (0.000s)
[139.110981] [031/132] (881s left) gem_exec_gttfill (all-engines)
[139.167874] Starting subtest: all-engines
[162.115520] Subtest all-engines: SUCCESS (22.943s)
[162.305294] [032/132] (857s left) gem_exec_await (wide-contexts)
[162.575667] Starting subtest: wide-contexts
[185.618309] Subtest wide-contexts: SUCCESS (23.037s)
[185.815082] [033/132] (834s left) kms_invalid_mode (bad-vsync-end)
[185.960967] Starting subtest: bad-vsync-end
[185.963348] Starting dynamic subtest: pipe-A-eDP-1
[186.245537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[186.255574] Starting dynamic subtest: pipe-B-eDP-1
[186.257836] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[186.266154] Starting dynamic subtest: pipe-C-eDP-1
[186.268415] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[186.276991] Starting dynamic subtest: pipe-D-eDP-1
[186.279314] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[186.281700] Subtest bad-vsync-end: SUCCESS (0.291s)
[187.140228] [034/132] (833s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[187.406862] Starting subtest: cursor-rapid-movement-256x85
[187.452034] Subtest cursor-rapid-movement-256x85: SKIP (0.041s)
[187.612267] [035/132] (832s left) perf_pmu (most-busy-check-all)
[187.654824] Starting subtest: most-busy-check-all
[187.657235] Starting dynamic subtest: rcs0
[188.886741] Dynamic subtest rcs0: SUCCESS (1.230s)
[188.896918] Starting dynamic subtest: bcs0
[190.870905] Dynamic subtest bcs0: SUCCESS (1.982s)
[190.883369] Starting dynamic subtest: vcs0
[192.918759] Dynamic subtest vcs0: SUCCESS (2.045s)
[192.930967] Starting dynamic subtest: vcs1
[194.903764] Dynamic subtest vcs1: SUCCESS (1.983s)
[194.915640] Starting dynamic subtest: vecs0
[196.885773] Dynamic subtest vecs0: SUCCESS (1.980s)
[196.897581] Starting dynamic subtest: ccs0
[198.935544] Dynamic subtest ccs0: SUCCESS (2.048s)
[198.938319] Subtest most-busy-check-all: SUCCESS (11.280s)
[199.043251] [036/132] (821s left) kms_big_fb (linear-16bpp-rotate-180)
[199.137224] Starting subtest: linear-16bpp-rotate-180
[200.417065] Subtest linear-16bpp-rotate-180: SUCCESS (1.279s)
[200.541653] [037/132] (819s left) gem_exec_params (cliprects-invalid)
[200.606196] Starting subtest: cliprects-invalid
[200.608135] Subtest cliprects-invalid: SUCCESS (0.000s)
[200.714909] [038/132] (819s left) kms_draw_crc (draw-method-mmap-cpu)
[200.805365] Starting subtest: draw-method-mmap-cpu
[200.807036] Starting dynamic subtest: xrgb8888-untiled
[201.014965] Dynamic subtest xrgb8888-untiled: SUCCESS (0.211s)
[201.024381] Starting dynamic subtest: rgb565-untiled
[201.237212] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[201.246253] Starting dynamic subtest: xrgb2101010-untiled
[201.437091] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[201.445857] Starting dynamic subtest: xbgr16161616f-untiled
[201.659270] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[201.667922] Starting dynamic subtest: xrgb8888-xtiled
[201.781914] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[201.792077] Starting dynamic subtest: rgb565-xtiled
[201.914815] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[201.922913] Starting dynamic subtest: xrgb2101010-xtiled
[202.026124] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[202.034832] Starting dynamic subtest: xbgr16161616f-xtiled
[202.159504] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[202.168531] Starting dynamic subtest: xrgb8888-4tiled
[202.337431] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.177s)
[202.348035] Starting dynamic subtest: rgb565-4tiled
[202.470654] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[202.480147] Starting dynamic subtest: xrgb2101010-4tiled
[202.603933] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[202.612539] Starting dynamic subtest: xbgr16161616f-4tiled
[202.737272] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[202.739225] Subtest draw-method-mmap-cpu: SUCCESS (1.933s)
[202.843530] [039/132] (817s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[202.900925] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[202.902850] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[202.988319] [040/132] (817s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[203.044190] Starting subtest: etime-single-wait-for-submit-submitted
[203.153379] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s)
[203.228163] [041/132] (817s left) kms_cursor_legacy (torture-move)
[203.342301] Starting subtest: torture-move
[203.344497] Starting dynamic subtest: pipe-A
[209.142385] Dynamic subtest pipe-A: SUCCESS (5.797s)
[209.153521] Starting dynamic subtest: pipe-B
[216.266694] Dynamic subtest pipe-B: SUCCESS (7.124s)
[216.277388] Starting dynamic subtest: pipe-C
[223.232494] Dynamic subtest pipe-C: SUCCESS (6.964s)
[223.249247] Starting dynamic subtest: pipe-D
[229.755203] Dynamic subtest pipe-D: SUCCESS (6.522s)
[229.765725] Starting dynamic subtest: all-pipes
[236.025759] Dynamic subtest all-pipes: SUCCESS (6.268s)
[236.028190] Subtest torture-move: SUCCESS (32.681s)
[236.187993] [042/132] (784s left) i915_drm_fdinfo (busy)
[236.228628] Starting subtest: busy
[236.230999] Starting dynamic subtest: rcs0
[236.269187] Dynamic subtest rcs0: SKIP (0.038s)
[236.280292] Starting dynamic subtest: bcs0
[236.284558] Dynamic subtest bcs0: SKIP (0.001s)
[236.294773] Starting dynamic subtest: vcs0
[236.298811] Dynamic subtest vcs0: SKIP (0.000s)
[236.306830] Starting dynamic subtest: vcs1
[236.310986] Dynamic subtest vcs1: SKIP (0.000s)
[236.318819] Starting dynamic subtest: vecs0
[236.323030] Dynamic subtest vecs0: SKIP (0.000s)
[236.330837] Starting dynamic subtest: ccs0
[236.335062] Dynamic subtest ccs0: SKIP (0.000s)
[236.339125] Subtest busy: SKIP (0.044s)
[236.374876] [043/132] (784s left) kms_async_flips (test-cursor)
[236.481030] Starting subtest: test-cursor
[236.853832] Starting dynamic subtest: pipe-A-eDP-1
[237.589628] Dynamic subtest pipe-A-eDP-1: SKIP (0.733s)
[237.971042] Starting dynamic subtest: pipe-B-eDP-1
[238.729209] Dynamic subtest pipe-B-eDP-1: SKIP (0.761s)
[239.105382] Starting dynamic subtest: pipe-C-eDP-1
[239.855335] Dynamic subtest pipe-C-eDP-1: SKIP (0.752s)
[240.225766] Starting dynamic subtest: pipe-D-eDP-1
[240.995088] Dynamic subtest pipe-D-eDP-1: SKIP (0.775s)
[240.999633] Subtest test-cursor: SKIP (4.512s)
[242.191727] [044/132] (778s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[242.288415] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[242.292779] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[242.384158] [045/132] (778s left) gem_ctx_engines (independent)
[242.431453] Starting subtest: independent
[242.433897] Starting dynamic subtest: rcs0
[242.555343] Dynamic subtest rcs0: SUCCESS (0.122s)
[242.567417] Starting dynamic subtest: bcs0
[242.656641] Dynamic subtest bcs0: SUCCESS (0.103s)
[242.665770] Starting dynamic subtest: vcs0
[242.776952] Dynamic subtest vcs0: SUCCESS (0.118s)
[242.788850] Starting dynamic subtest: vcs1
[242.903049] Dynamic subtest vcs1: SUCCESS (0.125s)
[242.914821] Starting dynamic subtest: vecs0
[243.043356] Dynamic subtest vecs0: SUCCESS (0.140s)
[243.055656] Starting dynamic subtest: ccs0
[243.183959] Dynamic subtest ccs0: SUCCESS (0.140s)
[243.195567] Starting dynamic subtest: all-engines
[243.649947] Dynamic subtest all-engines: SUCCESS (0.465s)
[243.652661] Subtest independent: SUCCESS (1.218s)
[244.089812] [046/132] (776s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[244.190293] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[244.192669] Starting dynamic subtest: pipe-A-eDP-1
[244.213960] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[244.224287] Starting dynamic subtest: pipe-B-eDP-1
[244.243760] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[244.251911] Starting dynamic subtest: pipe-C-eDP-1
[244.271446] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[244.279426] Starting dynamic subtest: pipe-D-eDP-1
[244.299045] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[244.300950] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[246.446422] [047/132] (774s left) syncobj_eventfd (invalid-bad-pad)
[246.513099] Starting subtest: invalid-bad-pad
[246.515345] Subtest invalid-bad-pad: SUCCESS (0.000s)
[246.625554] [048/132] (774s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[246.723936] Starting subtest: plane-downscale-factor-0-5-with-rotation
[246.726120] Starting dynamic subtest: pipe-A
[246.743454] Dynamic subtest pipe-A: SKIP (0.015s)
[246.752951] Starting dynamic subtest: pipe-B
[246.771643] Dynamic subtest pipe-B: SKIP (0.029s)
[246.780158] Starting dynamic subtest: pipe-C
[246.801320] Dynamic subtest pipe-C: SKIP (0.028s)
[246.809709] Starting dynamic subtest: pipe-D
[246.829333] Dynamic subtest pipe-D: SKIP (0.028s)
[246.832846] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.103s)
[246.925358] [049/132] (774s left) perf_pmu (busy)
[246.968672] Starting subtest: busy
[246.970975] Starting dynamic subtest: rcs0
[247.561963] Dynamic subtest rcs0: SUCCESS (0.595s)
[247.578102] Starting dynamic subtest: bcs0
[248.131364] Dynamic subtest bcs0: SUCCESS (0.567s)
[248.141138] Starting dynamic subtest: vcs0
[249.942332] Dynamic subtest vcs0: SUCCESS (1.807s)
[249.952824] Starting dynamic subtest: vcs1
[251.926078] Dynamic subtest vcs1: SUCCESS (1.980s)
[251.936221] Starting dynamic subtest: vecs0
[253.846497] Dynamic subtest vecs0: SUCCESS (1.917s)
[253.856199] Starting dynamic subtest: ccs0
[254.413686] Dynamic subtest ccs0: SUCCESS (0.566s)
[254.416277] Subtest busy: SUCCESS (7.449s)
[254.518171] [050/132] (766s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[254.583941] Starting subtest: saturated-hostile-nopreempt
[254.586309] Starting dynamic subtest: rcs0
[254.630500] Dynamic subtest rcs0: SKIP (0.044s)
[254.639841] Starting dynamic subtest: bcs0
[254.685887] Dynamic subtest bcs0: SKIP (0.053s)
[254.696159] Starting dynamic subtest: vcs0
[254.706648] Dynamic subtest vcs0: SKIP (0.019s)
[254.715108] Starting dynamic subtest: vcs1
[254.730606] Dynamic subtest vcs1: SKIP (0.023s)
[254.738645] Starting dynamic subtest: vecs0
[254.749760] Dynamic subtest vecs0: SKIP (0.018s)
[254.758090] Starting dynamic subtest: ccs0
[254.769174] Dynamic subtest ccs0: SKIP (0.018s)
[254.773663] Subtest saturated-hostile-nopreempt: SKIP (0.183s)
[254.848433] [051/132] (766s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[254.920316] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[254.922706] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[255.029127] [052/132] (766s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[255.119958] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[255.146392] Starting dynamic subtest: pipe-A-plane-0
[255.434644] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[255.443457] Starting dynamic subtest: pipe-A-plane-3
[255.668304] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[256.742215] Starting dynamic subtest: pipe-B-plane-0
[257.023618] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[257.037506] Starting dynamic subtest: pipe-B-plane-3
[257.256360] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[257.563835] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.445s)
[258.425270] [053/132] (762s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[258.529620] Starting subtest: psr-farfromfence-mmap-gtt
[258.533994] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[258.616418] [054/132] (762s left) gem_exec_params (invalid-bsd-ring)
[258.669457] Starting subtest: invalid-bsd-ring
[258.671701] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[258.768015] [055/132] (762s left) gem_mmap (bad-offset)
[258.825972] Subtest bad-offset: SKIP (0.000s)
[258.884767] [056/132] (762s left) kms_sequence (get-busy)
[258.979053] Starting subtest: get-busy
[258.981183] Starting dynamic subtest: pipe-A-eDP-1
[260.920086] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[260.929171] Starting dynamic subtest: pipe-B-eDP-1
[263.532015] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.612s)
[263.543690] Starting dynamic subtest: pipe-C-eDP-1
[266.128635] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.593s)
[266.138277] Starting dynamic subtest: pipe-D-eDP-1
[268.680582] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s)
[268.682894] Subtest get-busy: SUCCESS (9.702s)
[269.476909] [057/132] (751s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[269.596928] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[269.601191] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[269.689235] [058/132] (751s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[269.802401] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[279.193785] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.394s)
[279.342537] [059/132] (742s left) gem_exec_schedule (implicit-write-read)
[279.424622] Starting subtest: implicit-write-read
[279.426804] Starting dynamic subtest: rcs0
[279.532235] Dynamic subtest rcs0: SUCCESS (0.114s)
[279.542695] Starting dynamic subtest: vcs0
[279.621880] Dynamic subtest vcs0: SUCCESS (0.088s)
[279.634900] Starting dynamic subtest: vcs1
[279.695916] Dynamic subtest vcs1: SUCCESS (0.074s)
[279.707845] Starting dynamic subtest: vecs0
[279.780028] Dynamic subtest vecs0: SUCCESS (0.083s)
[279.792227] Starting dynamic subtest: ccs0
[279.860996] Dynamic subtest ccs0: SUCCESS (0.080s)
[279.863817] Subtest implicit-write-read: SUCCESS (0.443s)
[281.002772] [060/132] (740s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[281.111635] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[281.115779] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[281.224227] [061/132] (740s left) sw_sync (alloc_merge_fence)
[281.265797] Starting subtest: alloc_merge_fence
[281.268247] Subtest alloc_merge_fence: SUCCESS (0.000s)
[281.316559] [062/132] (740s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[281.406532] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[281.417256] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[281.517453] [063/132] (740s left) gem_userptr_blits (readonly-unsync)
[281.589322] Subtest readonly-unsync: SKIP (0.000s)
[281.704753] [064/132] (739s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[281.806180] Starting subtest: primary-y-tiled-reflect-x-0
[281.866040] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s)
[281.972768] [065/132] (739s left) kms_cursor_crc (cursor-sliding-32x10)
[282.140174] Starting subtest: cursor-sliding-32x10
[282.182718] Subtest cursor-sliding-32x10: SKIP (0.041s)
[282.484497] [066/132] (739s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[282.573130] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[286.960454] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.389s)
[288.152192] [067/132] (733s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[288.248536] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[295.009054] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.763s)
[295.204861] [068/132] (726s left) i915_pm_rc6_residency (rc6-accuracy)
[295.277821] Starting subtest: rc6-accuracy
[295.280437] Starting dynamic subtest: gt0
[298.448065] Dynamic subtest gt0: SUCCESS (3.169s)
[298.459501] Starting dynamic subtest: gt1
[301.619980] Dynamic subtest gt1: SUCCESS (3.168s)
[301.622728] Subtest rc6-accuracy: SUCCESS (6.343s)
[301.708449] [069/132] (720s left) gen9_exec_parse (bb-chained)
[301.768112] Subtest bb-chained: SKIP (0.000s)
[301.838634] [070/132] (720s left) gem_ppgtt (shrink-vs-evict-pinned)
[301.894521] Starting subtest: shrink-vs-evict-pinned
[307.884243] Subtest shrink-vs-evict-pinned: SUCCESS (5.988s)
[307.988279] [071/132] (713s left) api_intel_bb (blit-noreloc-keep-cache)
[308.042224] Starting subtest: blit-noreloc-keep-cache
[308.053074] Subtest blit-noreloc-keep-cache: SUCCESS (0.013s)
[308.141243] [072/132] (713s left) syncobj_wait (multi-wait-signaled)
[308.196885] Starting subtest: multi-wait-signaled
[308.199542] Subtest multi-wait-signaled: SUCCESS (0.000s)
[308.300582] [073/132] (713s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[308.395111] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[308.399076] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[308.525211] [074/132] (713s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[308.579825] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[308.655645] [075/132] (713s left) kms_psr (fbc-psr-sprite-blt)
[308.745651] Starting subtest: fbc-psr-sprite-blt
[308.747988] Starting dynamic subtest: eDP-1
[308.752537] Dynamic subtest eDP-1: SKIP (0.000s)
[308.756935] Subtest fbc-psr-sprite-blt: SKIP (0.003s)
[308.832767] [076/132] (713s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[308.935079] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[315.160031] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.227s)
[316.369113] [077/132] (705s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[316.476941] Starting subtest: plane-ctm3x4-lut1d
[316.601082] Starting dynamic subtest: pipe-A-plane-0
[316.961352] Dynamic subtest pipe-A-plane-0: FAIL (0.186s)
[316.972989] Starting dynamic subtest: pipe-A-plane-1
[317.185775] Dynamic subtest pipe-A-plane-1: FAIL (0.165s)
[317.195641] Starting dynamic subtest: pipe-A-plane-2
[317.422061] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[318.345352] Starting dynamic subtest: pipe-B-plane-0
[318.798511] Dynamic subtest pipe-B-plane-0: FAIL (0.185s)
[318.807433] Starting dynamic subtest: pipe-B-plane-1
[319.109589] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[319.121747] Starting dynamic subtest: pipe-B-plane-2
[319.420706] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[320.083597] Starting dynamic subtest: pipe-C-plane-0
[320.577828] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[320.589109] Starting dynamic subtest: pipe-C-plane-1
[320.987074] Dynamic subtest pipe-C-plane-1: FAIL (0.608s)
[320.998278] Starting dynamic subtest: pipe-C-plane-2
[321.359065] Dynamic subtest pipe-C-plane-2: FAIL (0.156s)
[322.158411] Starting dynamic subtest: pipe-D-plane-0
[322.740105] Dynamic subtest pipe-D-plane-0: FAIL (0.129s)
[322.750465] Starting dynamic subtest: pipe-D-plane-1
[323.200619] Dynamic subtest pipe-D-plane-1: FAIL (0.606s)
[323.211068] Starting dynamic subtest: pipe-D-plane-2
[323.648927] Dynamic subtest pipe-D-plane-2: FAIL (0.557s)
[323.738991] Subtest plane-ctm3x4-lut1d: FAIL (7.263s)
[324.607460] [078/132] (697s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[324.696837] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[324.701159] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[324.795137] [079/132] (697s left) syncobj_wait (wait-any-snapshot)
[324.844986] Starting subtest: wait-any-snapshot
[324.924723] Subtest wait-any-snapshot: SUCCESS (0.081s)
[325.001874] [080/132] (697s left) gem_userptr_blits (stress-mm-invalidate-close)
[325.061407] Starting subtest: stress-mm-invalidate-close
[327.209936] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[327.326627] [081/132] (695s left) kms_content_protection (lic-type-1)
[327.469976] Starting subtest: lic-type-1
[327.474615] Subtest lic-type-1: SKIP (0.000s)
[327.591593] [082/132] (694s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[327.676079] Starting subtest: fbc-psr2-cursor-plane-onoff
[327.678246] Starting dynamic subtest: eDP-1
[327.682106] Dynamic subtest eDP-1: SKIP (0.000s)
[327.686138] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[327.747837] [083/132] (694s left) gem_exec_balancer (parallel)
[328.007838] Starting subtest: parallel
[328.942100] Subtest parallel: SUCCESS (0.935s)
[329.979381] [084/132] (692s left) gem_basic (bad-close)
[330.041822] Starting subtest: bad-close
[330.045954] Subtest bad-close: SUCCESS (0.000s)
[330.148691] [085/132] (692s left) kms_rotation_crc (primary-rotation-270)
[330.248265] Starting subtest: primary-rotation-270
[330.252655] Subtest primary-rotation-270: SKIP (0.001s)
[330.322921] [086/132] (692s left) syncobj_timeline (invalid-wait-bad-flags)
[330.380374] Starting subtest: invalid-wait-bad-flags
[330.382411] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[330.486263] [087/132] (692s left) gem_exec_async (forked-writes)
[330.544635] Starting subtest: forked-writes
[330.546873] Starting dynamic subtest: rcs0
[330.572684] Dynamic subtest rcs0: SUCCESS (0.028s)
[330.583526] Starting dynamic subtest: bcs0
[330.596180] Dynamic subtest bcs0: SUCCESS (0.022s)
[330.606129] Starting dynamic subtest: vcs0
[330.616557] Dynamic subtest vcs0: SUCCESS (0.020s)
[330.626195] Starting dynamic subtest: vcs1
[330.642039] Dynamic subtest vcs1: SUCCESS (0.024s)
[330.651640] Starting dynamic subtest: vecs0
[330.664887] Dynamic subtest vecs0: SUCCESS (0.022s)
[330.674493] Starting dynamic subtest: ccs0
[330.687954] Dynamic subtest ccs0: SUCCESS (0.022s)
[330.690206] Subtest forked-writes: SUCCESS (0.144s)
[330.930811] [088/132] (691s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[331.018412] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[331.020760] Starting dynamic subtest: pipe-A-eDP-1
[331.041169] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[331.053636] Starting dynamic subtest: pipe-B-eDP-1
[331.072089] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[331.080861] Starting dynamic subtest: pipe-C-eDP-1
[331.099499] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[331.108436] Starting dynamic subtest: pipe-D-eDP-1
[331.127075] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[331.129146] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[333.175054] [089/132] (689s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[333.246639] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[333.318976] [090/132] (689s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[333.414806] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[333.416953] Starting dynamic subtest: pipe-A-eDP-1
[333.438513] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[333.447991] Starting dynamic subtest: pipe-B-eDP-1
[333.468745] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[333.477481] Starting dynamic subtest: pipe-C-eDP-1
[333.498287] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[333.508249] Starting dynamic subtest: pipe-D-eDP-1
[333.529394] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[333.533332] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[335.647199] [091/132] (687s left) kms_psr (psr-sprite-mmap-gtt)
[335.753129] Starting subtest: psr-sprite-mmap-gtt
[335.755275] Starting dynamic subtest: eDP-1
[337.169645] Dynamic subtest eDP-1: SKIP (1.414s)
[337.174207] Subtest psr-sprite-mmap-gtt: SKIP (1.416s)
[337.352503] [092/132] (685s left) gem_eio (in-flight-contexts-1us)
[337.569775] Starting subtest: in-flight-contexts-1us
[348.905592] Subtest in-flight-contexts-1us: SUCCESS (11.334s)
[349.025726] [093/132] (673s left) i915_hangman (engine-engine-hang)
[349.102326] Starting subtest: engine-engine-hang
[349.104538] Starting dynamic subtest: rcs0
[350.900746] Dynamic subtest rcs0: SUCCESS (1.799s)
[350.915364] Starting dynamic subtest: bcs0
[352.883512] Dynamic subtest bcs0: SUCCESS (1.980s)
[352.896487] Starting dynamic subtest: vcs0
[354.868326] Dynamic subtest vcs0: SUCCESS (1.982s)
[354.879943] Starting dynamic subtest: vcs1
[356.852832] Dynamic subtest vcs1: SUCCESS (1.982s)
[356.865056] Starting dynamic subtest: vecs0
[358.898970] Dynamic subtest vecs0: SUCCESS (2.043s)
[358.911040] Starting dynamic subtest: ccs0
[360.884554] Dynamic subtest ccs0: SUCCESS (1.983s)
[360.887288] Subtest engine-engine-hang: SUCCESS (11.785s)
[361.023631] [094/132] (661s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[363.070705] Starting subtest: dpms-mode-unset-non-lpsp
[364.233723] Subtest dpms-mode-unset-non-lpsp: SKIP (1.160s)
[364.606457] [095/132] (658s left) gem_lmem_swapping (heavy-random)
[364.646843] Subtest heavy-random: SKIP (0.000s)
[364.698745] [096/132] (658s left) gem_pread (snoop)
[364.751250] Subtest snoop: SKIP (0.000s)
[364.815278] [097/132] (658s left) kms_cursor_crc (cursor-onscreen-32x32)
[364.967224] Starting subtest: cursor-onscreen-32x32
[365.008600] Subtest cursor-onscreen-32x32: SKIP (0.043s)
[365.320096] [098/132] (657s left) gem_exec_whisper (basic-fds-forked-all)
[365.376024] Starting subtest: basic-fds-forked-all
[389.001929] Subtest basic-fds-forked-all: SUCCESS (23.622s)
[389.190072] [099/132] (633s left) core_getclient (basic)
[389.240797] Starting subtest: basic
[389.243037] Subtest basic: SUCCESS (0.000s)
[389.337309] [100/132] (633s left) i915_selftest (perf)
[392.014296] Starting subtest: perf
[392.018641] Starting dynamic subtest: engine_cs
[394.746011] Dynamic subtest engine_cs: SUCCESS (2.731s)
[394.760243] Starting dynamic subtest: request
[400.022340] Dynamic subtest request: SUCCESS (5.275s)
[400.031955] Starting dynamic subtest: migrate
[404.345270] Dynamic subtest migrate: SUCCESS (4.321s)
[404.354811] Starting dynamic subtest: region
[409.992546] Dynamic subtest region: SUCCESS (5.627s)
[409.997057] Subtest perf: SUCCESS (17.960s)
[410.025673] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[410.026403] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[410.029543] [101/132] (613s left) kms_chamelium_edid (hdmi-mode-timings)
[411.808378] Subtest hdmi-mode-timings: SKIP (0.000s)
[412.640287] [FACT kms_chamelium_edid (hdmi-mode-timings)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[412.641546] [FACT kms_chamelium_edid (hdmi-mode-timings)] new: kernel.kmod_is_loaded.i915: true
[412.645221] [102/132] (610s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[412.750603] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[413.821932] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.070s)
[413.956363] [103/132] (609s left) gem_softpin (allocator-nopin-reserve)
[414.018528] Starting subtest: allocator-nopin-reserve
[414.119960] Subtest allocator-nopin-reserve: SUCCESS (0.101s)
[414.252942] [104/132] (609s left) prime_vgem (basic-fence-read)
[414.325407] Starting subtest: basic-fence-read
[414.332056] Subtest basic-fence-read: SKIP (0.007s)
[414.438102] [105/132] (608s left) gem_busy (semaphore)
[414.619695] Subtest semaphore: SKIP (0.000s)
[414.848261] [106/132] (608s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[414.938360] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[414.942801] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[415.022422] [107/132] (608s left) kms_psr (fbc-pr-primary-blt)
[415.112786] Starting subtest: fbc-pr-primary-blt
[415.117175] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[415.187977] [108/132] (608s left) gem_exec_reloc (basic-wc-noreloc)
[415.239625] Subtest basic-wc-noreloc: SKIP (0.000s)
[415.306362] [109/132] (608s left) gem_exec_fence (submit67)
[415.477656] Starting subtest: submit67
[415.482414] Subtest submit67: SKIP (0.000s)
[417.007441] [110/132] (606s left) gem_ctx_param (invalid-ctx-get)
[417.053766] Starting subtest: invalid-ctx-get
[417.056061] Subtest invalid-ctx-get: SUCCESS (0.000s)
[417.131855] [111/132] (606s left) gem_vm_create (execbuf)
[417.186207] Starting subtest: execbuf
[417.193923] Subtest execbuf: SUCCESS (0.008s)
[417.320307] [112/132] (606s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[417.411796] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[417.415896] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[417.518943] [113/132] (606s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[417.620897] Starting subtest: psr2-cursor-plane-update-sf
[417.623134] Starting dynamic subtest: pipe-A-eDP-1
[418.187367] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.571s)
[418.196717] Starting dynamic subtest: pipe-B-eDP-1
[419.447472] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.257s)
[419.449758] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.831s)
[420.324104] [114/132] (603s left) kms_pm_rpm (i2c)
[422.036768] Starting subtest: i2c
[427.565592] Subtest i2c: SUCCESS (5.530s)
[427.688369] [115/132] (596s left) gem_mmap_gtt (hang-busy)
[427.745735] Subtest hang-busy: SKIP (0.000s)
[427.808219] [116/132] (596s left) kms_psr (psr-cursor-blt)
[427.901794] Starting subtest: psr-cursor-blt
[427.904023] Starting dynamic subtest: eDP-1
[429.636248] Dynamic subtest eDP-1: SUCCESS (1.733s)
[429.638546] Subtest psr-cursor-blt: SUCCESS (1.734s)
[430.546060] [117/132] (593s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[430.647686] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[430.652230] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[430.733949] [118/132] (593s left) kms_frontbuffer_tracking (psr-1p-rte)
[430.834390] Starting subtest: psr-1p-rte
[436.197285] Subtest psr-1p-rte: SUCCESS (5.366s)
[436.321471] [119/132] (587s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[436.441381] Starting subtest: cursorB-vs-flipA-varying-size
[436.445856] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[436.583035] [120/132] (587s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[436.692164] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[436.696202] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[436.814550] [121/132] (587s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[436.914344] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[436.916655] Starting dynamic subtest: pipe-A-eDP-1
[436.941649] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[436.952958] Starting dynamic subtest: pipe-B-eDP-1
[436.976679] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[436.984794] Starting dynamic subtest: pipe-C-eDP-1
[437.007827] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[437.016502] Starting dynamic subtest: pipe-D-eDP-1
[437.040567] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[437.044690] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[439.108181] [122/132] (585s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[439.206063] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[446.259466] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.056s)
[446.378398] [123/132] (577s left) kms_setmode (invalid-clone-single-crtc)
[446.435074] Starting subtest: invalid-clone-single-crtc
[446.441646] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[446.551625] [124/132] (577s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[446.644296] Starting subtest: crc-primary-suspend-y-tiled-ccs
[446.646620] Starting dynamic subtest: pipe-A-eDP-1
[446.657155] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[446.667347] Starting dynamic subtest: pipe-B-eDP-1
[446.676132] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[446.685096] Starting dynamic subtest: pipe-C-eDP-1
[446.693786] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[446.702409] Starting dynamic subtest: pipe-D-eDP-1
[446.711188] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[446.715529] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[448.900107] [125/132] (575s left) gem_userptr_blits (create-destroy-sync)
[448.965773] Starting subtest: create-destroy-sync
[453.971366] Subtest create-destroy-sync: SUCCESS (5.006s)
[454.107273] [126/132] (570s left) gem_exec_balancer (parallel-out-fence)
[454.362904] Starting subtest: parallel-out-fence
[455.547515] Subtest parallel-out-fence: SUCCESS (1.185s)
[455.663831] [127/132] (568s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[455.763506] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[455.767658] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[455.862715] [128/132] (568s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[455.958465] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[462.997138] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.042s)
[463.133446] [129/132] (561s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[463.259159] Starting subtest: basic-flip-after-cursor-legacy
[464.197991] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.938s)
[465.026891] [130/132] (559s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[465.115922] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[465.907575] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.792s)
[466.066539] [131/132] (558s left) gem_basic (create-fd-close)
[466.121024] Starting subtest: create-fd-close
[466.125222] Subtest create-fd-close: SUCCESS (0.000s)
[466.222961] [132/132] (558s left) gem_exec_schedule (u-independent)
[466.287545] Starting subtest: u-independent
[466.289443] Starting dynamic subtest: rcs0
[467.926277] Dynamic subtest rcs0: SUCCESS (1.646s)
[467.939514] Starting dynamic subtest: vcs0
[469.937398] Dynamic subtest vcs0: SUCCESS (2.009s)
[469.970034] Starting dynamic subtest: vcs1
[471.904419] Dynamic subtest vcs1: SUCCESS (1.965s)
[471.922097] Starting dynamic subtest: vecs0
[473.886753] Dynamic subtest vecs0: SUCCESS (1.979s)
[473.898982] Starting dynamic subtest: ccs0
[475.925237] Dynamic subtest ccs0: SUCCESS (2.036s)
[475.928008] Subtest u-independent: SUCCESS (9.648s)
[476.221044] Closing watchdogs
results: parsing output: 0/ for test: kms_lease
results: parsing output: 1/ for test: kms_pm_backlight
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: tools_test
results: parsing output: 4/ for test: gem_ctx_isolation
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_vblank
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: dmabuf_sync_file
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_async_flips
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: i915_query
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_plane_alpha_blend
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: gem_shrink
results: parsing output: 29/ for test: kms_getfb
results: parsing output: 30/ for test: gem_exec_gttfill
results: parsing output: 31/ for test: gem_exec_await
results: parsing output: 32/ for test: kms_invalid_mode
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_exec_params
results: parsing output: 37/ for test: kms_draw_crc
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: i915_drm_fdinfo
results: parsing output: 42/ for test: kms_async_flips
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_ctx_engines
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: syncobj_eventfd
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_params
results: parsing output: 54/ for test: gem_mmap
results: parsing output: 55/ for test: kms_sequence
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: gem_userptr_blits
results: parsing output: 63/ for test: kms_rotation_crc
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: i915_pm_rc6_residency
results: parsing output: 68/ for test: gen9_exec_parse
results: parsing output: 69/ for test: gem_ppgtt
results: parsing output: 70/ for test: api_intel_bb
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_color_pipeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: kms_content_protection
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: gem_basic
results: parsing output: 84/ for test: kms_rotation_crc
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_exec_async
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: gem_eio
results: parsing output: 92/ for test: i915_hangman
results: parsing output: 93/ for test: kms_pm_rpm
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: gem_pread
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: core_getclient
results: parsing output: 99/ for test: i915_selftest
results: parsing output: 100/ for test: kms_chamelium_edid
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: prime_vgem
results: parsing output: 104/ for test: gem_busy
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: gem_ctx_param
results: parsing output: 110/ for test: gem_vm_create
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_plane
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_setmode
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_basic
results: parsing output: 131/ for test: gem_exec_schedule
Done.