[71.404829] Initializing watchdogs [71.404978] /dev/watchdog0 [71.428996] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300) [71.436517] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [71.440416] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [71.448626] [001/133] (960s left) perf_pmu (busy-start) [71.527922] Starting subtest: busy-start [71.530073] Starting dynamic subtest: rcs0 [74.054537] Dynamic subtest rcs0: SUCCESS (2.525s) [74.071895] Starting dynamic subtest: bcs0 [76.572347] Dynamic subtest bcs0: SUCCESS (2.515s) [76.586979] Starting dynamic subtest: vcs0 [79.597510] Dynamic subtest vcs0: SUCCESS (3.021s) [79.599571] Subtest busy-start: SUCCESS (8.063s) [79.734145] [002/133] (952s left) gem_exec_flush (basic-wb-rw-before-default) [79.802709] Starting subtest: basic-wb-rw-before-default [85.251719] Subtest basic-wb-rw-before-default: SUCCESS (5.444s) [85.483561] [003/133] (946s left) kms_lease (lessee-list) [85.978095] Starting subtest: lessee-list [85.979860] Starting dynamic subtest: pipe-A-HDMI-A-1 [85.981709] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s) [85.994451] Starting dynamic subtest: pipe-B-HDMI-A-1 [85.996131] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [85.997801] Subtest lessee-list: SUCCESS (0.005s) [86.582889] [004/133] (945s left) i915_drm_fdinfo (virtual-busy-hang-all) [86.642386] Subtest virtual-busy-hang-all: SKIP (0.000s) [86.702053] [005/133] (945s left) kms_atomic_interruptible (legacy-setmode) [87.197878] Starting subtest: legacy-setmode [87.200700] Starting dynamic subtest: pipe-A-HDMI-A-1 [93.495380] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.293s) [93.497286] Subtest legacy-setmode: SUCCESS (6.294s) [94.205453] [006/133] (938s left) kms_color (ctm-max) [94.700496] Starting subtest: ctm-max [94.702736] Starting dynamic subtest: pipe-A-HDMI-A-1 [95.186920] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.488s) [95.208496] Starting dynamic subtest: pipe-B-HDMI-A-1 [95.688332] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.499s) [95.691827] Subtest ctm-max: SUCCESS (0.988s) [96.407260] [007/133] (935s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [96.901164] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [98.752865] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (1.853s) [99.400772] [008/133] (932s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [99.895670] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [99.898966] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [100.499742] [009/133] (931s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [100.982985] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [100.984724] Starting dynamic subtest: pipe-A [100.989650] Dynamic subtest pipe-A: SKIP (0.001s) [101.001847] Starting dynamic subtest: pipe-B [101.006674] Dynamic subtest pipe-B: SKIP (0.001s) [101.009826] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.003s) [101.596412] [010/133] (930s left) kms_big_fb (y-tiled-64bpp-rotate-180) [102.098912] Starting subtest: y-tiled-64bpp-rotate-180 [102.102610] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [102.712996] [011/133] (929s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [103.210089] Starting subtest: primary-x-tiled-reflect-x-180 [103.214453] Subtest primary-x-tiled-reflect-x-180: SKIP (0.001s) [103.811665] [012/133] (928s left) kms_flip (2x-flip-vs-expired-vblank) [104.301678] Starting subtest: 2x-flip-vs-expired-vblank [104.303370] Starting dynamic subtest: AB-VGA1-HDMI-A1 [134.703237] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.392s) [134.704877] Subtest 2x-flip-vs-expired-vblank: SUCCESS (30.396s) [135.473026] [013/133] (897s left) api_intel_allocator (fork-simple-stress) [135.536444] Starting subtest: fork-simple-stress [140.964638] Subtest fork-simple-stress: SUCCESS (5.427s) [141.114885] [014/133] (891s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [141.614082] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [141.629126] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [142.216869] [015/133] (890s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [142.719989] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [142.736258] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [143.325729] [016/133] (889s left) gem_mmap (bad-size) [143.383300] Starting subtest: bad-size [143.385035] Subtest bad-size: SUCCESS (0.001s) [143.527244] [017/133] (889s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [143.592209] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [143.596148] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [143.805419] [018/133] (889s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [144.306539] Starting subtest: psr-2p-primscrn-cur-indfb-move [144.309857] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [144.924061] [019/133] (887s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [145.415885] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [145.419242] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [146.023219] [020/133] (886s left) syncobj_timeline (wait-all-snapshot) [146.086885] Starting subtest: wait-all-snapshot [146.169813] Subtest wait-all-snapshot: SUCCESS (0.082s) [146.301102] [021/133] (886s left) gem_partial_pwrite_pread (reads) [146.363392] Starting subtest: reads [147.493458] Subtest reads: SUCCESS (1.129s) [147.649523] [022/133] (885s left) syncobj_basic (create-signaled) [147.707469] Starting subtest: create-signaled [147.709145] Subtest create-signaled: SUCCESS (0.000s) [147.832176] [023/133] (885s left) kms_chamelium_frames (dp-crc-multiple) [148.400904] Subtest dp-crc-multiple: SKIP (0.000s) [148.819619] [024/133] (884s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [149.315073] Starting subtest: cursorA-vs-flipA-varying-size [160.217974] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.904s) [160.928105] [025/133] (872s left) gem_ctx_persistence (hang) [160.994117] Subtest hang: SKIP (0.000s) [161.055998] [026/133] (872s left) kms_psr (pr-primary-page-flip) [161.542950] Subtest pr-primary-page-flip: SKIP (0.000s) [161.839438] [027/133] (871s left) gem_lmem_swapping (heavy-random) [161.902287] Subtest heavy-random: SKIP (0.000s) [161.955840] [028/133] (871s left) kms_addfb_basic (master-rmfb) [162.013744] Starting subtest: master-rmfb [162.015415] Subtest master-rmfb: SUCCESS (0.001s) [163.061426] [029/133] (870s left) kms_addfb_basic (invalid-get-prop-any) [163.120531] Starting subtest: invalid-get-prop-any [163.122193] Subtest invalid-get-prop-any: SUCCESS (0.000s) [164.139124] [030/133] (869s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [164.198259] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [164.250228] [031/133] (869s left) gem_exec_basic (basic) [164.312208] Starting subtest: basic [164.313850] Starting dynamic subtest: rcs0-smem [164.315586] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [164.329023] Starting dynamic subtest: bcs0-smem [164.330912] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [164.343679] Starting dynamic subtest: vcs0-smem [164.345462] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [164.347256] Subtest basic: SUCCESS (0.004s) [164.558424] [032/133] (869s left) gem_mmap_offset (oob-read) [164.615922] Starting subtest: oob-read [164.617718] Subtest oob-read: SUCCESS (0.001s) [164.752405] [033/133] (868s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [164.816111] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.000s) [164.865098] [034/133] (868s left) kms_cursor_crc (cursor-random-64x21) [165.354056] Starting subtest: cursor-random-64x21 [165.411950] Subtest cursor-random-64x21: SKIP (0.055s) [166.000667] [035/133] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [166.505167] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [166.508536] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [167.081847] [036/133] (866s left) kms_plane_alpha_blend (constant-alpha-max) [167.572461] Starting subtest: constant-alpha-max [167.730146] Subtest constant-alpha-max: SKIP (0.158s) [168.516955] [037/133] (865s left) gem_exec_fence (keep-in-fence) [168.707039] Subtest keep-in-fence: SKIP (0.000s) [169.150867] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true [169.154791] [038/133] (864s left) i915_pm_rps (min-max-config-idle) [169.215845] Starting subtest: min-max-config-idle [169.412524] Subtest min-max-config-idle: SUCCESS (0.199s) [169.583412] [039/133] (864s left) dumb_buffer (map-invalid-size) [169.641309] Starting subtest: map-invalid-size [169.643478] Subtest map-invalid-size: SUCCESS (0.000s) [169.761838] [040/133] (864s left) gem_mmap_gtt (basic-write-gtt) [169.820208] Starting subtest: basic-write-gtt [169.969908] Subtest basic-write-gtt: SUCCESS (0.153s) [170.114928] [041/133] (863s left) gem_userptr_blits (set-cache-level) [170.182999] Starting subtest: set-cache-level [170.184786] Subtest set-cache-level: SUCCESS (0.000s) [170.348915] [042/133] (863s left) kms_psr (psr-primary-render) [170.848729] Subtest psr-primary-render: SKIP (0.000s) [171.154241] [043/133] (863s left) gem_create (create-ext-placement-sanity-check) [171.328316] Starting subtest: create-ext-placement-sanity-check [171.332801] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s) [171.479358] [044/133] (862s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [171.970719] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [171.972358] Starting dynamic subtest: AB-VGA1-HDMI-A1 [173.541119] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (1.569s) [173.542851] Subtest 2x-flip-vs-dpms-off-vs-modeset: SUCCESS (1.572s) [174.257623] [045/133] (860s left) gem_exec_schedule (u-lateslice) [174.333119] Subtest u-lateslice: SKIP (0.000s) [174.575059] [046/133] (859s left) kms_flip (dpms-off-confusion-interruptible) [175.067164] Starting subtest: dpms-off-confusion-interruptible [175.068838] Starting dynamic subtest: A-VGA1 [182.782840] Dynamic subtest A-VGA1: SUCCESS (7.714s) [182.796829] Starting dynamic subtest: B-VGA1 [190.456158] Dynamic subtest B-VGA1: SUCCESS (7.671s) [190.468219] Starting dynamic subtest: A-HDMI-A1 [198.180372] Dynamic subtest A-HDMI-A1: SUCCESS (7.722s) [198.195202] Starting dynamic subtest: B-HDMI-A1 [205.931540] Dynamic subtest B-HDMI-A1: SUCCESS (7.748s) [205.933807] Subtest dpms-off-confusion-interruptible: SUCCESS (30.865s) [206.743613] [047/133] (827s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render) [207.244022] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render [207.249857] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [207.854121] [048/133] (826s left) kms_plane (plane-position-hole) [208.340943] Starting subtest: plane-position-hole [208.615612] Starting dynamic subtest: pipe-A-plane-1 [209.039853] Dynamic subtest pipe-A-plane-1: SUCCESS (0.424s) [209.051958] Starting dynamic subtest: pipe-A-plane-2 [209.055172] Dynamic subtest pipe-A-plane-2: SUCCESS (0.009s) [209.355107] Starting dynamic subtest: pipe-B-plane-1 [209.767751] Dynamic subtest pipe-B-plane-1: SUCCESS (0.423s) [209.779510] Starting dynamic subtest: pipe-B-plane-2 [209.782749] Dynamic subtest pipe-B-plane-2: SUCCESS (0.009s) [209.784344] Subtest plane-position-hole: SUCCESS (1.438s) [210.502106] [049/133] (824s left) kms_draw_crc (draw-method-mmap-cpu) [210.987360] Starting subtest: draw-method-mmap-cpu [210.989330] Starting dynamic subtest: xrgb8888-untiled [211.260399] Dynamic subtest xrgb8888-untiled: SUCCESS (0.272s) [211.273009] Starting dynamic subtest: rgb565-untiled [211.542816] Dynamic subtest rgb565-untiled: SUCCESS (0.280s) [211.554891] Starting dynamic subtest: xrgb2101010-untiled [211.858664] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.314s) [211.872481] Starting dynamic subtest: xbgr16161616f-untiled [212.191789] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.331s) [212.203876] Starting dynamic subtest: xrgb8888-xtiled [212.374501] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.181s) [212.386978] Starting dynamic subtest: rgb565-xtiled [212.541333] Dynamic subtest rgb565-xtiled: SUCCESS (0.164s) [212.553085] Starting dynamic subtest: xrgb2101010-xtiled [212.723891] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.180s) [212.736102] Starting dynamic subtest: xbgr16161616f-xtiled [212.939938] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.214s) [212.942042] Subtest draw-method-mmap-cpu: SUCCESS (1.955s) [213.582278] [050/133] (820s left) gem_mmap_gtt (medium-copy-xy) [213.644324] Starting subtest: medium-copy-XY [214.795711] Subtest medium-copy-XY: SUCCESS (1.151s) [214.939758] [051/133] (819s left) vgem_basic (bad-flag) [215.087784] Starting subtest: bad-flag [215.089718] Subtest bad-flag: SUCCESS (0.000s) [215.210155] [052/133] (819s left) gem_ctx_persistence (engines-hostile-preempt) [215.273151] Subtest engines-hostile-preempt: SKIP (0.000s) [215.341133] [053/133] (819s left) kms_sequence (queue-idle) [215.838058] Starting subtest: queue-idle [215.840122] Starting dynamic subtest: pipe-A-HDMI-A-1 [218.065218] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.225s) [218.077097] Starting dynamic subtest: pipe-B-HDMI-A-1 [220.311896] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.245s) [220.313616] Subtest queue-idle: SUCCESS (4.474s) [221.036511] [054/133] (813s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [221.529955] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [221.840601] [055/133] (813s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [222.341913] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [222.345896] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [222.936939] [056/133] (811s left) kms_atomic (atomic-plane-damage) [223.434171] Starting subtest: atomic-plane-damage [223.741817] Subtest atomic-plane-damage: SKIP (0.307s) [224.524652] [057/133] (810s left) kms_big_fb (linear-16bpp-rotate-90) [225.021910] Starting subtest: linear-16bpp-rotate-90 [225.040562] Subtest linear-16bpp-rotate-90: SKIP (0.017s) [225.658391] [058/133] (809s left) perf (stress-open-close) [225.848276] Subtest stress-open-close: SKIP (0.000s) [225.919250] [059/133] (809s left) gem_workarounds (basic-read-fd) [225.989892] Starting subtest: basic-read-fd [225.994009] Subtest basic-read-fd: SUCCESS (0.004s) [226.161568] [060/133] (808s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [226.661169] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [226.670820] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.008s) [227.284401] [061/133] (807s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [227.784747] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [227.788013] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [228.384929] [062/133] (806s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [228.879018] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [228.882334] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [229.469770] [063/133] (805s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [229.970697] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [229.976250] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [230.586752] [064/133] (804s left) kms_cursor_crc (cursor-offscreen-32x10) [231.083910] Starting subtest: cursor-offscreen-32x10 [231.142353] Subtest cursor-offscreen-32x10: SKIP (0.054s) [231.732829] [065/133] (803s left) kms_psr (psr2-primary-render) [232.227018] Subtest psr2-primary-render: SKIP (0.000s) [232.520514] [066/133] (802s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [233.010329] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [233.013671] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [233.628405] [067/133] (801s left) gem_exec_schedule (noreorder-priority) [233.702062] Subtest noreorder-priority: SKIP (0.000s) [233.943810] [068/133] (801s left) gem_softpin (allocator-evict) [234.009096] Subtest allocator-evict: SKIP (0.000s) [234.143066] [069/133] (801s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite) [234.634730] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite [236.103856] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.471s) [236.734151] [070/133] (798s left) gem_exec_reloc (basic-cpu-gtt-active) [236.800134] Starting subtest: basic-cpu-gtt-active [236.911471] Subtest basic-cpu-gtt-active: SUCCESS (0.110s) [237.938957] [071/133] (797s left) gem_ctx_shared (single-timeline) [238.001786] Subtest single-timeline: SKIP (0.000s) [238.136341] [072/133] (797s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [238.194483] Starting subtest: etime-multi-wait-all-for-submit-submitted [238.300586] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s) [238.412097] [073/133] (797s left) syncobj_timeline (etime-single-wait-all-submitted) [238.473133] Starting subtest: etime-single-wait-all-submitted [238.579807] Subtest etime-single-wait-all-submitted: SUCCESS (0.107s) [238.716285] [074/133] (797s left) kms_chamelium_hpd (dp-hpd-storm) [239.279767] Subtest dp-hpd-storm: SKIP (0.000s) [239.690412] [075/133] (796s left) kms_flip (2x-flip-vs-suspend) [240.184514] Starting subtest: 2x-flip-vs-suspend [240.186209] Starting dynamic subtest: AB-VGA1-HDMI-A1 [427.054643] Per-test timeout exceeded. Killing the current test with SIGQUIT. [433.872874] Closing watchdogs [433.879713] Initializing watchdogs [433.879782] /dev/watchdog0 [433.901955] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300) [433.913388] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [433.915224] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [433.915982] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true [433.920253] [076/133] (608s left) kms_psr (fbc-psr2-sprite-plane-move) [434.420961] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s) [434.724105] [077/133] (607s left) gem_exec_params (mmapped) [434.784744] Starting subtest: mmapped [434.786375] Subtest mmapped: SUCCESS (0.001s) [434.958091] [078/133] (607s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [435.458965] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [435.462729] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [436.075264] [079/133] (606s left) sw_sync (sync_merge_invalid) [436.139093] Starting subtest: sync_merge_invalid [436.143464] Subtest sync_merge_invalid: SUCCESS (0.004s) [436.233431] [080/133] (606s left) perf_pmu (busy) [436.296453] Starting subtest: busy [436.298517] Starting dynamic subtest: rcs0 [436.841109] Dynamic subtest rcs0: SUCCESS (0.546s) [436.865515] Starting dynamic subtest: bcs0 [437.399758] Dynamic subtest bcs0: SUCCESS (0.557s) [437.418239] Starting dynamic subtest: vcs0 [438.447233] Dynamic subtest vcs0: SUCCESS (1.046s) [438.449216] Subtest busy: SUCCESS (2.154s) [438.567904] [081/133] (603s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [438.628628] Starting subtest: multi-wait-for-submit-submitted-signaled [438.630835] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [438.759164] [082/133] (603s left) gem_mmap_wc (write-wc-read-gtt) [438.818530] Starting subtest: write-wc-read-gtt [438.992659] Subtest write-wc-read-gtt: SUCCESS (0.176s) [439.119616] [083/133] (603s left) kms_hdmi_inject (inject-audio) [439.257926] Starting subtest: inject-audio [439.261393] Subtest inject-audio: SKIP (0.000s) [439.493891] [084/133] (603s left) kms_flip (2x-blocking-wf_vblank) [439.984424] Starting subtest: 2x-blocking-wf_vblank [439.986110] Starting dynamic subtest: AB-VGA1-HDMI-A1 [470.710465] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.722s) [470.712445] Subtest 2x-blocking-wf_vblank: SUCCESS (30.726s) [471.545203] [085/133] (571s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [472.037532] Starting subtest: plane-all-transition-nonblocking-fencing [472.039235] Starting dynamic subtest: pipe-A-HDMI-A-1 [473.216130] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.175s) [473.314474] Starting dynamic subtest: pipe-B-HDMI-A-1 [474.619912] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.319s) [474.702017] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (2.664s) [475.424367] [086/133] (567s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [475.914478] Starting subtest: flip-vs-cursor-crc-legacy [476.445355] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.531s) [477.164666] [087/133] (565s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area) [477.657490] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [477.957067] [088/133] (564s left) gem_exec_params (invalid-ring2) [478.017653] Starting subtest: invalid-ring2 [478.019490] Subtest invalid-ring2: SUCCESS (0.000s) [478.169454] [089/133] (564s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [478.663912] Starting subtest: fbcpsr-slowdraw [478.667229] Subtest fbcpsr-slowdraw: SKIP (0.000s) [479.274853] [090/133] (563s left) kms_joiner (basic-force-ultra-joiner) [479.766755] Starting subtest: basic-force-ultra-joiner [479.770247] Subtest basic-force-ultra-joiner: SKIP (0.000s) [480.355399] [091/133] (562s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping) [480.839201] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping [480.845662] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.000s) [481.449222] [092/133] (561s left) kms_vblank (query-forked-busy-hang) [481.938211] Starting subtest: query-forked-busy-hang [481.942868] Starting dynamic subtest: pipe-A-HDMI-A-1 [488.480622] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.538s) [488.496939] Starting dynamic subtest: pipe-B-HDMI-A-1 [494.473975] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.990s) [494.475698] Subtest query-forked-busy-hang: SUCCESS (12.535s) [495.198599] [093/133] (547s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [495.695771] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [495.698981] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [496.305535] [094/133] (546s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [496.801628] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [496.805183] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [497.421520] [095/133] (545s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [497.484397] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SKIP (0.000s) [497.557789] [096/133] (545s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [497.618706] Starting subtest: multi-wait-all-for-submit-submitted-signaled [497.722507] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s) [497.851480] [097/133] (545s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip) [498.346443] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip [498.351970] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [498.973370] [098/133] (544s left) gem_exec_whisper (basic-fds-forked) [499.046968] Starting subtest: basic-fds-forked [501.530167] Subtest basic-fds-forked: SUCCESS (2.483s) [501.790653] [099/133] (541s left) kms_addfb_basic (bad-pitch-999) [501.852651] Starting subtest: bad-pitch-999 [501.854492] Subtest bad-pitch-999: SUCCESS (0.000s) [502.918071] [100/133] (540s left) kms_prop_blob (basic) [502.979729] Starting subtest: basic [502.981560] Subtest basic: SUCCESS (0.000s) [503.111434] [101/133] (540s left) syncobj_basic (bad-pad-fd-to-handle) [503.172319] Starting subtest: bad-pad-fd-to-handle [503.174154] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [503.301130] [102/133] (540s left) kms_cursor_crc (cursor-sliding-256x256) [503.796937] Starting subtest: cursor-sliding-256x256 [503.798876] Starting dynamic subtest: pipe-A-HDMI-A-1 [507.358948] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.560s) [507.401508] Starting dynamic subtest: pipe-B-HDMI-A-1 [510.966420] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.574s) [510.968068] Subtest cursor-sliding-256x256: SUCCESS (7.167s) [511.681482] [103/133] (532s left) gem_busy (busy) [511.760660] Starting subtest: busy [511.762284] Starting dynamic subtest: all-engines [511.785473] Dynamic subtest all-engines: SUCCESS (0.026s) [511.812986] Starting dynamic subtest: rcs0 [511.815021] Dynamic subtest rcs0: SUCCESS (0.017s) [511.837207] Starting dynamic subtest: bcs0 [511.838982] Dynamic subtest bcs0: SUCCESS (0.014s) [511.856823] Starting dynamic subtest: vcs0 [511.858675] Dynamic subtest vcs0: SUCCESS (0.017s) [511.860556] Subtest busy: SUCCESS (0.080s) [512.241239] [104/133] (531s left) i915_pm_rps (thresholds) [512.303912] Starting subtest: thresholds [512.305650] Starting dynamic subtest: gt0 [522.345853] Dynamic subtest gt0: SUCCESS (10.039s) [522.348073] Subtest thresholds: SUCCESS (10.042s) [522.458083] [105/133] (521s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [522.521432] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [522.617480] [106/133] (521s left) gem_softpin (evict-snoop-interruptible) [522.680527] Starting subtest: evict-snoop-interruptible [522.684267] Subtest evict-snoop-interruptible: SKIP (0.000s) [522.807915] [107/133] (521s left) gem_mmap_gtt (big-bo) [522.864827] Starting subtest: big-bo [523.315893] Subtest big-bo: SUCCESS (0.450s) [523.486667] [108/133] (520s left) gem_partial_pwrite_pread (write-display) [523.624010] Starting subtest: write-display [527.427463] Subtest write-display: SUCCESS (3.803s) [527.589380] [109/133] (516s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [527.648785] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.000s) [527.726646] [110/133] (516s left) kms_psr (fbc-pr-cursor-blt) [528.229408] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [528.542764] [111/133] (515s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled) [528.610537] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [528.612184] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s) [528.753000] [112/133] (515s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [528.820187] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [528.821961] Starting dynamic subtest: smem [528.826275] Dynamic subtest smem: SKIP (0.000s) [528.830053] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.002s) [529.075406] [113/133] (515s left) gem_mmap (basic) [529.136340] Starting subtest: basic [529.146816] Subtest basic: SUCCESS (0.000s) [529.277667] [114/133] (515s left) gem_exec_gttfill (basic) [529.351817] Starting subtest: basic [532.780139] Subtest basic: SUCCESS (3.431s) [533.001971] [115/133] (511s left) kms_addfb_basic (size-max) [533.543363] Starting subtest: size-max [533.545104] Subtest size-max: SUCCESS (0.000s) [534.162565] [116/133] (510s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [534.224955] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [534.309679] [117/133] (510s left) api_intel_bb (purge-bb) [534.368940] Starting subtest: purge-bb [534.372480] Subtest purge-bb: SUCCESS (0.001s) [534.536420] [118/133] (510s left) kms_cursor_legacy (forked-move) [535.021803] Starting subtest: forked-move [535.023519] Starting dynamic subtest: pipe-A [540.458994] Dynamic subtest pipe-A: SUCCESS (5.435s) [540.475121] Starting dynamic subtest: pipe-B [545.921083] Dynamic subtest pipe-B: SUCCESS (5.460s) [545.939885] Starting dynamic subtest: all-pipes [551.375884] Dynamic subtest all-pipes: SUCCESS (5.453s) [551.377609] Subtest forked-move: SUCCESS (16.355s) [551.985308] [119/133] (492s left) gen9_exec_parse (bb-chained) [552.048475] Subtest bb-chained: SKIP (0.000s) [552.116190] [120/133] (492s left) kms_concurrent (multi-plane-atomic-lowres) [552.611122] Starting subtest: multi-plane-atomic-lowres [552.612768] Starting dynamic subtest: pipe-A-HDMI-A-1 [553.118632] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.508s) [553.120598] Subtest multi-plane-atomic-lowres: SUCCESS (0.510s) [553.852615] [121/133] (491s left) gem_exec_reloc (basic-gtt-wc-noreloc) [553.916251] Starting subtest: basic-gtt-wc-noreloc [553.920462] Subtest basic-gtt-wc-noreloc: SUCCESS (0.003s) [554.960273] [122/133] (490s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [555.028712] Starting subtest: multi-wait-available-unsubmitted-submitted [555.030472] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s) [555.145460] [123/133] (489s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render) [555.639765] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render [557.547191] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (1.910s) [558.197337] [124/133] (486s left) kms_pm_dc (dc3co-vpb-simulation) [569.303469] Subtest dc3co-vpb-simulation: SKIP (0.000s) [569.382741] [125/133] (475s left) kms_big_fb (x-tiled-8bpp-rotate-90) [569.880364] Starting subtest: x-tiled-8bpp-rotate-90 [569.889651] Subtest x-tiled-8bpp-rotate-90: SKIP (0.008s) [570.492222] [126/133] (474s left) kms_plane_multiple (2x-tiling-none) [570.983456] Starting subtest: 2x-tiling-none [570.986846] Subtest 2x-tiling-none: SKIP (0.000s) [571.604103] [127/133] (473s left) gem_exec_balancer (bonded-false-hang) [571.669537] Subtest bonded-false-hang: SKIP (0.000s) [571.818574] [128/133] (473s left) i915_drm_fdinfo (idle) [571.878003] Subtest idle: SKIP (0.000s) [571.931278] [129/133] (473s left) kms_getfb (getfb2-handle-closed) [572.417028] Starting subtest: getfb2-handle-closed [572.418731] Subtest getfb2-handle-closed: SUCCESS (0.000s) [573.047072] [130/133] (472s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [573.111371] Starting subtest: invalid-bsd1-flag-on-vebox [573.114909] Subtest invalid-bsd1-flag-on-vebox: SKIP (0.000s) [573.275846] [131/133] (472s left) kms_psr (fbc-pr-suspend) [573.759569] Subtest fbc-pr-suspend: SKIP (0.000s) [574.071332] [132/133] (471s left) gem_softpin (overlap) [574.137417] Starting subtest: overlap [574.315607] Subtest overlap: SUCCESS (0.180s) [574.481462] [133/133] (471s left) gem_madvise (dontneed-before-mmap) [574.537194] Starting subtest: dontneed-before-mmap [574.545342] Subtest dontneed-before-mmap: SUCCESS (0.009s) [574.697096] Closing watchdogs results: parsing output: 0/ for test: perf_pmu results: parsing output: 1/ for test: gem_exec_flush results: parsing output: 2/ for test: kms_lease results: parsing output: 3/ for test: i915_drm_fdinfo results: parsing output: 4/ for test: kms_atomic_interruptible results: parsing output: 5/ for test: kms_color results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_plane_scaling results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: kms_rotation_crc results: parsing output: 11/ for test: kms_flip results: parsing output: 12/ for test: api_intel_allocator 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 results: parsing output: 16/ for test: gem_render_copy results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: syncobj_timeline results: parsing output: 20/ for test: gem_partial_pwrite_pread results: parsing output: 21/ for test: syncobj_basic results: parsing output: 22/ for test: kms_chamelium_frames results: parsing output: 23/ for test: kms_cursor_legacy results: parsing output: 24/ for test: gem_ctx_persistence results: parsing output: 25/ for test: kms_psr results: parsing output: 26/ for test: gem_lmem_swapping results: parsing output: 27/ for test: kms_addfb_basic results: parsing output: 28/ for test: kms_addfb_basic results: parsing output: 29/ for test: kms_ccs results: parsing output: 30/ for test: gem_exec_basic results: parsing output: 31/ for test: gem_mmap_offset results: parsing output: 32/ for test: kms_ccs results: parsing output: 33/ for test: kms_cursor_crc results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_plane_alpha_blend results: parsing output: 36/ for test: gem_exec_fence results: parsing output: 37/ for test: i915_pm_rps results: parsing output: 38/ for test: dumb_buffer results: parsing output: 39/ for test: gem_mmap_gtt results: parsing output: 40/ for test: gem_userptr_blits results: parsing output: 41/ for test: kms_psr results: parsing output: 42/ for test: gem_create results: parsing output: 43/ for test: kms_flip results: parsing output: 44/ for test: gem_exec_schedule results: parsing output: 45/ for test: kms_flip results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_plane results: parsing output: 48/ for test: kms_draw_crc results: parsing output: 49/ for test: gem_mmap_gtt results: parsing output: 50/ for test: vgem_basic results: parsing output: 51/ for test: gem_ctx_persistence results: parsing output: 52/ for test: kms_sequence results: parsing output: 53/ for test: kms_psr2_sf results: parsing output: 54/ for test: kms_big_fb results: parsing output: 55/ for test: kms_atomic results: parsing output: 56/ for test: kms_big_fb results: parsing output: 57/ for test: perf results: parsing output: 58/ for test: gem_workarounds results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_cursor_crc results: parsing output: 64/ for test: kms_psr results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gem_exec_schedule results: parsing output: 67/ for test: gem_softpin results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: gem_exec_reloc results: parsing output: 70/ for test: gem_ctx_shared results: parsing output: 71/ for test: syncobj_timeline results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: kms_chamelium_hpd results: parsing output: 74/ for test: kms_flip results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: gem_exec_params results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: sw_sync results: parsing output: 79/ for test: perf_pmu results: parsing output: 80/ for test: syncobj_wait results: parsing output: 81/ for test: gem_mmap_wc results: parsing output: 82/ for test: kms_hdmi_inject results: parsing output: 83/ for test: kms_flip results: parsing output: 84/ for test: kms_atomic_transition results: parsing output: 85/ for test: kms_cursor_legacy results: parsing output: 86/ for test: kms_psr2_sf results: parsing output: 87/ for test: gem_exec_params results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_joiner results: parsing output: 90/ for test: kms_plane results: parsing output: 91/ for test: kms_vblank results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_big_fb results: parsing output: 94/ for test: kms_flip_scaled_crc results: parsing output: 95/ for test: syncobj_wait results: parsing output: 96/ for test: kms_big_fb results: parsing output: 97/ for test: gem_exec_whisper results: parsing output: 98/ for test: kms_addfb_basic results: parsing output: 99/ for test: kms_prop_blob results: parsing output: 100/ for test: syncobj_basic results: parsing output: 101/ for test: kms_cursor_crc results: parsing output: 102/ for test: gem_busy results: parsing output: 103/ for test: i915_pm_rps results: parsing output: 104/ for test: kms_ccs results: parsing output: 105/ for test: gem_softpin results: parsing output: 106/ for test: gem_mmap_gtt results: parsing output: 107/ for test: gem_partial_pwrite_pread results: parsing output: 108/ for test: kms_ccs results: parsing output: 109/ for test: kms_psr results: parsing output: 110/ for test: syncobj_timeline results: parsing output: 111/ for test: gem_render_copy results: parsing output: 112/ for test: gem_mmap results: parsing output: 113/ for test: gem_exec_gttfill results: parsing output: 114/ for test: kms_addfb_basic results: parsing output: 115/ for test: kms_ccs results: parsing output: 116/ for test: api_intel_bb results: parsing output: 117/ for test: kms_cursor_legacy results: parsing output: 118/ for test: gen9_exec_parse results: parsing output: 119/ for test: kms_concurrent results: parsing output: 120/ for test: gem_exec_reloc results: parsing output: 121/ for test: syncobj_timeline results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_pm_dc results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: kms_plane_multiple results: parsing output: 126/ for test: gem_exec_balancer results: parsing output: 127/ for test: i915_drm_fdinfo results: parsing output: 128/ for test: kms_getfb results: parsing output: 129/ for test: gem_exec_params results: parsing output: 130/ for test: kms_psr results: parsing output: 131/ for test: gem_softpin results: parsing output: 132/ for test: gem_madvise Done.