[47.456784] Initializing watchdogs [47.457031] /dev/watchdog0 [47.467181] [001/171] (960s left) i915_module_load (load) [47.603225] Starting subtest: load [49.303341] Subtest load: SUCCESS (1.701s) [49.355260] [002/171] (958s left) core_auth (basic-auth) [49.728925] Starting subtest: basic-auth [49.730015] Subtest basic-auth: SUCCESS (0.001s) [49.807965] [003/171] (958s left) debugfs_test (read_all_entries) [49.961275] Starting subtest: read_all_entries [50.106683] Subtest read_all_entries: SUCCESS (0.144s) [50.244297] [004/171] (957s left) debugfs_test (basic-hwmon) [50.379837] Starting subtest: basic-hwmon [50.382150] Subtest basic-hwmon: SKIP (0.001s) [50.510462] [005/171] (957s left) fbdev (eof) [50.654067] Starting subtest: eof [50.655157] Subtest eof: SUCCESS (0.000s) [50.711642] [006/171] (957s left) fbdev (info) [50.835252] Starting subtest: info [50.836415] Subtest info: SUCCESS (0.000s) [50.910183] [007/171] (957s left) fbdev (nullptr) [51.037112] Starting subtest: nullptr [51.038165] Subtest nullptr: SUCCESS (0.000s) [51.093592] [008/171] (957s left) fbdev (read) [51.220328] Starting subtest: read [52.731894] Subtest read: SUCCESS (1.510s) [52.796294] [009/171] (955s left) fbdev (write) [52.940672] Starting subtest: write [53.741704] Subtest write: SUCCESS (0.802s) [53.797586] [010/171] (954s left) gem_basic (bad-close) [53.926340] Starting subtest: bad-close [53.928509] Subtest bad-close: SUCCESS (0.000s) [53.996869] [011/171] (954s left) gem_basic (create-close) [54.120898] Starting subtest: create-close [54.123511] Subtest create-close: SUCCESS (0.000s) [54.196574] [012/171] (954s left) gem_basic (create-fd-close) [54.322055] Starting subtest: create-fd-close [54.324345] Subtest create-fd-close: SUCCESS (0.000s) [54.396222] [013/171] (953s left) gem_busy (busy@all-engines) [54.539702] Starting subtest: busy [54.541107] Starting dynamic subtest: all-engines [54.603500] Dynamic subtest all-engines: SUCCESS (0.062s) [54.604870] Subtest busy: SUCCESS (0.063s) [54.930960] [014/171] (953s left) gem_close_race (basic-process) [55.081439] Starting subtest: basic-process [55.152896] Subtest basic-process: SUCCESS (0.073s) [55.331195] [015/171] (952s left) gem_close_race (basic-threads) [55.475856] Starting subtest: basic-threads [56.623025] Subtest basic-threads: SUCCESS (1.149s) [56.811255] [016/171] (951s left) gem_ctx_create (basic) [56.976143] Starting subtest: basic [56.977203] Subtest basic: SUCCESS (0.000s) [57.161783] [017/171] (951s left) gem_ctx_create (basic-files) [57.319759] Starting subtest: basic-files [59.352346] Subtest basic-files: SUCCESS (2.033s) [59.563303] [018/171] (948s left) gem_ctx_exec (basic) [59.694630] Starting subtest: basic [59.698177] Subtest basic: SUCCESS (0.004s) [59.767274] [019/171] (948s left) gem_exec_basic (basic) [59.902409] Starting subtest: basic [59.904204] Starting dynamic subtest: rcs0-smem [59.905355] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [59.915252] Starting dynamic subtest: bcs0-smem [59.916821] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [59.926310] Starting dynamic subtest: vcs0-smem [59.927428] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [59.936445] Starting dynamic subtest: vecs0-smem [59.937612] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [59.938846] Subtest basic: SUCCESS (0.006s) [60.096475] [020/171] (948s left) gem_exec_create (basic) [60.244849] Starting subtest: basic [60.247112] Starting dynamic subtest: smem [62.286823] Dynamic subtest smem: SUCCESS (2.044s) [62.287972] Subtest basic: SUCCESS (2.044s) [62.464284] [021/171] (945s left) gem_exec_fence (basic-busy) [62.729880] Starting subtest: basic-busy [62.730986] Starting dynamic subtest: rcs0 [62.746330] Dynamic subtest rcs0: SUCCESS (0.018s) [62.758219] Starting dynamic subtest: bcs0 [62.767261] Dynamic subtest bcs0: SUCCESS (0.017s) [62.778198] Starting dynamic subtest: vcs0 [62.783933] Dynamic subtest vcs0: SUCCESS (0.018s) [62.793927] Starting dynamic subtest: vecs0 [62.797368] Dynamic subtest vecs0: SUCCESS (0.015s) [62.798444] Subtest basic-busy: SUCCESS (0.070s) [63.431427] [022/171] (945s left) gem_exec_fence (basic-wait) [63.713817] Starting subtest: basic-wait [63.714905] Starting dynamic subtest: rcs0 [63.741091] Dynamic subtest rcs0: SUCCESS (0.028s) [63.753749] Starting dynamic subtest: bcs0 [63.758569] Dynamic subtest bcs0: SUCCESS (0.017s) [63.770428] Starting dynamic subtest: vcs0 [63.772685] Dynamic subtest vcs0: SUCCESS (0.013s) [63.783529] Starting dynamic subtest: vecs0 [63.786035] Dynamic subtest vecs0: SUCCESS (0.015s) [63.787226] Subtest basic-wait: SUCCESS (0.074s) [64.364167] [023/171] (944s left) gem_exec_fence (basic-await) [64.630966] Starting subtest: basic-await [64.632930] Starting dynamic subtest: rcs0 [64.730966] Dynamic subtest rcs0: SUCCESS (0.100s) [64.742207] Starting dynamic subtest: bcs0 [64.826207] Dynamic subtest bcs0: SUCCESS (0.092s) [64.836550] Starting dynamic subtest: vcs0 [64.917980] Dynamic subtest vcs0: SUCCESS (0.093s) [64.928392] Starting dynamic subtest: vecs0 [65.009883] Dynamic subtest vecs0: SUCCESS (0.092s) [65.011333] Subtest basic-await: SUCCESS (0.379s) [65.564375] [024/171] (942s left) gem_exec_fence (nb-await) [65.830102] Starting subtest: nb-await [65.832763] Starting dynamic subtest: rcs0 [65.896871] Dynamic subtest rcs0: SUCCESS (0.067s) [65.907152] Starting dynamic subtest: bcs0 [65.965800] Dynamic subtest bcs0: SUCCESS (0.067s) [65.977742] Starting dynamic subtest: vcs0 [66.026993] Dynamic subtest vcs0: SUCCESS (0.062s) [66.038700] Starting dynamic subtest: vecs0 [66.095560] Dynamic subtest vecs0: SUCCESS (0.068s) [66.096711] Subtest nb-await: SUCCESS (0.266s) [66.665535] [025/171] (941s left) gem_exec_gttfill (basic) [66.810653] Starting subtest: basic [78.651621] Subtest basic: SUCCESS (11.839s) [78.832607] [026/171] (929s left) gem_exec_parallel (engines) [79.087049] Starting subtest: engines [79.090707] Starting dynamic subtest: basic [81.928552] Dynamic subtest basic: SUCCESS (2.843s) [81.940662] Starting dynamic subtest: contexts [85.438884] Dynamic subtest contexts: SUCCESS (3.508s) [85.450406] Starting dynamic subtest: fds [89.577195] Dynamic subtest fds: SUCCESS (4.136s) [89.596437] Starting dynamic subtest: userptr [92.636201] Dynamic subtest userptr: SUCCESS (3.063s) [92.637291] Subtest engines: SUCCESS (13.552s) [92.835373] [027/171] (915s left) gem_exec_store (basic) [92.981518] Starting subtest: basic [93.024941] Subtest basic: SUCCESS (0.045s) [93.215363] [028/171] (915s left) gem_flink_basic (bad-flink) [93.345072] Starting subtest: bad-flink [93.346285] Subtest bad-flink: SUCCESS (0.000s) [93.415779] [029/171] (915s left) gem_flink_basic (bad-open) [93.545035] Starting subtest: bad-open [93.546200] Subtest bad-open: SUCCESS (0.000s) [93.614542] [030/171] (915s left) gem_flink_basic (basic) [93.743218] Starting subtest: basic [93.744289] Subtest basic: SUCCESS (0.000s) [93.831913] [031/171] (914s left) gem_flink_basic (double-flink) [93.958381] Starting subtest: double-flink [93.959444] Subtest double-flink: SUCCESS (0.000s) [94.032282] [032/171] (914s left) gem_flink_basic (flink-lifetime) [94.162468] Starting subtest: flink-lifetime [94.163625] Subtest flink-lifetime: SUCCESS (0.001s) [94.232599] [033/171] (914s left) gem_huc_copy (huc-copy) [94.366600] Starting subtest: huc-copy [94.369154] Subtest huc-copy: SKIP (0.000s) [94.464321] [034/171] (914s left) gem_linear_blits (basic) [94.759670] Starting subtest: basic [94.773142] Subtest basic: SUCCESS (0.014s) [94.909348] [035/171] (913s left) gem_mmap (basic) [95.140208] Starting subtest: basic [95.146210] Subtest basic: SUCCESS (0.001s) [95.215634] [036/171] (913s left) gem_mmap_gtt (basic) [95.344994] Starting subtest: basic [95.346224] Subtest basic: SUCCESS (0.001s) [95.402738] [037/171] (913s left) gem_render_linear_blits (basic) [95.536482] Starting subtest: basic [95.596697] Subtest basic: SUCCESS (0.059s) [95.635525] [038/171] (913s left) gem_render_tiled_blits (basic) [95.770096] Starting subtest: basic [95.847360] Subtest basic: SUCCESS (0.074s) [95.903554] [039/171] (912s left) gem_ringfill (basic-all) [96.230678] Starting subtest: basic-all [97.413392] Subtest basic-all: SUCCESS (1.178s) [97.500551] [040/171] (911s left) gem_softpin (allocator-basic) [97.645795] Starting subtest: allocator-basic [97.822653] Subtest allocator-basic: SUCCESS (0.175s) [97.933391] [041/171] (910s left) gem_softpin (allocator-basic-reserve) [98.067329] Starting subtest: allocator-basic-reserve [98.236050] Subtest allocator-basic-reserve: SUCCESS (0.169s) [98.330971] [042/171] (910s left) gem_softpin (safe-alignment) [98.465784] Starting subtest: safe-alignment [98.487455] Subtest safe-alignment: SUCCESS (0.021s) [98.565294] [043/171] (910s left) gem_sync (basic-all) [98.715117] Starting subtest: basic-all [101.283652] Subtest basic-all: SUCCESS (2.570s) [101.466732] [044/171] (907s left) gem_sync (basic-each) [101.611560] Starting subtest: basic-each [104.023863] Subtest basic-each: SUCCESS (2.412s) [104.215337] [045/171] (904s left) gem_tiled_blits (basic) [104.511986] Starting subtest: basic [104.563082] Subtest basic: SUCCESS (0.052s) [104.686950] [046/171] (904s left) gem_tiled_fence_blits (basic) [105.062422] Starting subtest: basic [105.092414] Subtest basic: SUCCESS (0.031s) [105.228374] [047/171] (903s left) gem_tiled_pread_basic [105.783429] [048/171] (903s left) gem_wait (busy@all-engines) [105.930516] Starting subtest: busy [105.931745] Starting dynamic subtest: all-engines [106.447665] Dynamic subtest all-engines: SUCCESS (0.516s) [106.448814] Subtest busy: SUCCESS (0.517s) [106.649613] [049/171] (902s left) gem_wait (wait@all-engines) [106.795677] Starting subtest: wait [106.797439] Starting dynamic subtest: all-engines [107.825917] Dynamic subtest all-engines: SUCCESS (1.030s) [107.827086] Subtest wait: SUCCESS (1.030s) [108.031871] [050/171] (901s left) i915_getparams_basic (basic-eu-total) [108.161160] Starting subtest: basic-eu-total [108.163966] Subtest basic-eu-total: SUCCESS (0.000s) [108.231247] [051/171] (900s left) i915_getparams_basic (basic-subslice-total) [108.356339] Starting subtest: basic-subslice-total [108.358555] Subtest basic-subslice-total: SUCCESS (0.000s) [108.432083] [052/171] (900s left) i915_hangman (error-state-basic) [108.573840] Starting subtest: error-state-basic [108.590434] Subtest error-state-basic: SUCCESS (0.013s) [108.665771] [053/171] (900s left) i915_pciid [108.865621] [054/171] (900s left) kms_addfb_basic (addfb25-bad-modifier) [109.061284] Starting subtest: addfb25-bad-modifier [109.063309] Subtest addfb25-bad-modifier: SUCCESS (0.003s) [109.343024] [055/171] (899s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [109.595792] Starting subtest: addfb25-framebuffer-vs-set-tiling [109.596864] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [109.863398] [056/171] (899s left) kms_addfb_basic (addfb25-modifier-no-flag) [110.145252] Starting subtest: addfb25-modifier-no-flag [110.146343] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [110.347786] [057/171] (898s left) kms_addfb_basic (addfb25-x-tiled-legacy) [110.538306] Starting subtest: addfb25-x-tiled-legacy [110.539378] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [110.747672] [058/171] (898s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [110.939692] Starting subtest: addfb25-x-tiled-mismatch-legacy [110.940966] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [111.147740] [059/171] (898s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [111.404317] Starting subtest: addfb25-yf-tiled-legacy [111.405398] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [111.548047] [060/171] (897s left) kms_addfb_basic (addfb25-y-tiled-legacy) [111.803444] Starting subtest: addfb25-y-tiled-legacy [111.804556] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [111.947628] [061/171] (897s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [112.204471] Starting subtest: addfb25-y-tiled-small-legacy [112.205648] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [112.355944] [062/171] (897s left) kms_addfb_basic (bad-pitch-0) [112.482468] Starting subtest: bad-pitch-0 [112.483614] Subtest bad-pitch-0: SUCCESS (0.000s) [112.747810] [063/171] (896s left) kms_addfb_basic (bad-pitch-1024) [112.874736] Starting subtest: bad-pitch-1024 [112.875870] Subtest bad-pitch-1024: SUCCESS (0.000s) [113.147804] [064/171] (896s left) kms_addfb_basic (bad-pitch-128) [113.276141] Starting subtest: bad-pitch-128 [113.277206] Subtest bad-pitch-128: SUCCESS (0.000s) [113.547863] [065/171] (895s left) kms_addfb_basic (bad-pitch-256) [113.676245] Starting subtest: bad-pitch-256 [113.677321] Subtest bad-pitch-256: SUCCESS (0.000s) [113.947778] [066/171] (895s left) kms_addfb_basic (bad-pitch-32) [114.074771] Starting subtest: bad-pitch-32 [114.075838] Subtest bad-pitch-32: SUCCESS (0.000s) [114.347457] [067/171] (895s left) kms_addfb_basic (bad-pitch-63) [114.474967] Starting subtest: bad-pitch-63 [114.476113] Subtest bad-pitch-63: SUCCESS (0.000s) [114.747636] [068/171] (894s left) kms_addfb_basic (bad-pitch-65536) [114.876338] Starting subtest: bad-pitch-65536 [114.877537] Subtest bad-pitch-65536: SUCCESS (0.001s) [115.147619] [069/171] (894s left) kms_addfb_basic (bad-pitch-999) [115.273759] Starting subtest: bad-pitch-999 [115.274927] Subtest bad-pitch-999: SUCCESS (0.000s) [115.547573] [070/171] (894s left) kms_addfb_basic (basic) [115.676442] Starting subtest: basic [115.677536] Subtest basic: SUCCESS (0.000s) [115.947743] [071/171] (893s left) kms_addfb_basic (basic-x-tiled-legacy) [116.265352] Starting subtest: basic-x-tiled-legacy [116.266414] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [116.347894] [072/171] (893s left) kms_addfb_basic (basic-y-tiled-legacy) [116.663805] Starting subtest: basic-y-tiled-legacy [116.665100] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [116.747611] [073/171] (892s left) kms_addfb_basic (bo-too-small) [116.940437] Starting subtest: bo-too-small [116.941647] Subtest bo-too-small: SUCCESS (0.001s) [117.147736] [074/171] (892s left) kms_addfb_basic (bo-too-small-due-to-tiling) [117.340440] Starting subtest: bo-too-small-due-to-tiling [117.341668] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [117.580991] [075/171] (892s left) kms_addfb_basic (clobberred-modifier) [117.709035] Starting subtest: clobberred-modifier [117.710147] Subtest clobberred-modifier: SUCCESS (0.001s) [117.981056] [076/171] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling) [118.300242] Starting subtest: framebuffer-vs-set-tiling [118.301336] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [118.381112] [077/171] (891s left) kms_addfb_basic (invalid-get-prop) [118.702329] Starting subtest: invalid-get-prop [118.703469] Subtest invalid-get-prop: SUCCESS (0.000s) [118.781237] [078/171] (891s left) kms_addfb_basic (invalid-get-prop-any) [119.103347] Starting subtest: invalid-get-prop-any [119.104977] Subtest invalid-get-prop-any: SUCCESS (0.000s) [119.181284] [079/171] (890s left) kms_addfb_basic (invalid-set-prop) [119.501554] Starting subtest: invalid-set-prop [119.502801] Subtest invalid-set-prop: SUCCESS (0.000s) [119.586550] [080/171] (890s left) kms_addfb_basic (invalid-set-prop-any) [119.910362] Starting subtest: invalid-set-prop-any [119.911547] Subtest invalid-set-prop-any: SUCCESS (0.000s) [119.997878] [081/171] (889s left) kms_addfb_basic (no-handle) [120.123866] Starting subtest: no-handle [120.125109] Subtest no-handle: SUCCESS (0.000s) [120.397858] [082/171] (889s left) kms_addfb_basic (size-max) [120.587429] Starting subtest: size-max [120.588665] Subtest size-max: SUCCESS (0.000s) [120.797816] [083/171] (889s left) kms_addfb_basic (small-bo) [120.990227] Starting subtest: small-bo [120.991306] Subtest small-bo: SUCCESS (0.000s) [121.215572] [084/171] (888s left) kms_addfb_basic (tile-pitch-mismatch) [121.545192] Starting subtest: tile-pitch-mismatch [121.546251] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [121.632211] [085/171] (888s left) kms_addfb_basic (too-high) [121.829689] Starting subtest: too-high [121.832550] Subtest too-high: SUCCESS (0.003s) [122.048186] [086/171] (887s left) kms_addfb_basic (too-wide) [122.242156] Starting subtest: too-wide [122.243229] Subtest too-wide: SUCCESS (0.000s) [122.447896] [087/171] (887s left) kms_addfb_basic (unused-handle) [122.575924] Starting subtest: unused-handle [122.577200] Subtest unused-handle: SUCCESS (0.000s) [122.864992] [088/171] (887s left) kms_addfb_basic (unused-modifier) [123.006815] Starting subtest: unused-modifier [123.008431] Subtest unused-modifier: SUCCESS (0.000s) [123.281290] [089/171] (886s left) kms_addfb_basic (unused-offsets) [123.412068] Starting subtest: unused-offsets [123.413158] Subtest unused-offsets: SUCCESS (0.000s) [123.698170] [090/171] (886s left) kms_addfb_basic (unused-pitches) [123.827302] Starting subtest: unused-pitches [123.828385] Subtest unused-pitches: SUCCESS (0.000s) [124.115335] [091/171] (886s left) kms_busy (basic) [124.314402] Starting subtest: basic [124.318271] Starting dynamic subtest: flip [125.208276] Dynamic subtest flip: SUCCESS (0.885s) [125.228978] Starting dynamic subtest: modeset [126.717759] Dynamic subtest modeset: SUCCESS (1.503s) [126.719155] Subtest basic: SUCCESS (2.399s) [126.918901] [092/171] (883s left) kms_chamelium_hpd (dp-hpd-fast) [127.350376] Subtest dp-hpd-fast: SKIP (0.000s) [127.518596] [093/171] (882s left) kms_chamelium_edid (dp-edid-read) [127.957433] Subtest dp-edid-read: SKIP (0.000s) [128.125146] [094/171] (882s left) kms_chamelium_frames (dp-crc-fast) [128.565744] Subtest dp-crc-fast: SKIP (0.000s) [128.722470] [095/171] (881s left) kms_chamelium_hpd (hdmi-hpd-fast) [129.149717] Subtest hdmi-hpd-fast: SKIP (0.000s) [129.299342] [096/171] (880s left) kms_chamelium_edid (hdmi-edid-read) [129.743119] Subtest hdmi-edid-read: SKIP (0.000s) [129.911292] [097/171] (880s left) kms_chamelium_frames (hdmi-crc-fast) [130.342799] Subtest hdmi-crc-fast: SKIP (0.000s) [130.509273] [098/171] (879s left) kms_chamelium_hpd (vga-hpd-fast) [130.950822] Subtest vga-hpd-fast: SKIP (0.000s) [131.119429] [099/171] (879s left) kms_chamelium_edid (vga-edid-read) [131.558861] Subtest vga-edid-read: SKIP (0.000s) [131.717590] [100/171] (878s left) kms_prop_blob (basic) [131.843927] Starting subtest: basic [131.845188] Subtest basic: SUCCESS (0.000s) [131.926024] [101/171] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [132.130435] Starting subtest: basic-busy-flip-before-cursor-atomic [132.132865] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [132.210805] [102/171] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [132.408843] Starting subtest: basic-busy-flip-before-cursor-legacy [132.411140] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [132.493051] [103/171] (877s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [132.696833] Starting subtest: basic-flip-after-cursor-atomic [133.908934] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.213s) [134.103696] [104/171] (876s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [134.299149] Starting subtest: basic-flip-after-cursor-legacy [135.482720] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.183s) [135.676293] [105/171] (874s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [135.873707] Starting subtest: basic-flip-after-cursor-varying-size [137.067932] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.194s) [137.272528] [106/171] (873s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [137.474906] Starting subtest: basic-flip-before-cursor-atomic [138.684121] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.209s) [138.873891] [107/171] (871s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [139.081757] Starting subtest: basic-flip-before-cursor-legacy [140.299984] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.219s) [140.470665] [108/171] (870s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [140.673917] Starting subtest: basic-flip-before-cursor-varying-size [141.868908] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.198s) [142.076399] [109/171] (868s left) kms_flip (basic-flip-vs-dpms) [142.259212] Starting subtest: basic-flip-vs-dpms [142.265932] Starting dynamic subtest: A-HDMI-A2 [143.695103] Dynamic subtest A-HDMI-A2: SUCCESS (1.423s) [143.716813] Starting dynamic subtest: B-HDMI-A2 [144.874124] Dynamic subtest B-HDMI-A2: SUCCESS (1.176s) [144.894817] Starting dynamic subtest: C-HDMI-A2 [146.060160] Dynamic subtest C-HDMI-A2: SUCCESS (1.190s) [146.061241] Subtest basic-flip-vs-dpms: SUCCESS (3.800s) [146.326318] [110/171] (864s left) kms_flip (basic-flip-vs-modeset) [146.513129] Starting subtest: basic-flip-vs-modeset [146.519218] Starting dynamic subtest: A-HDMI-A2 [148.072763] Dynamic subtest A-HDMI-A2: SUCCESS (1.553s) [148.097892] Starting dynamic subtest: B-HDMI-A2 [149.293155] Dynamic subtest B-HDMI-A2: SUCCESS (1.215s) [149.315896] Starting dynamic subtest: C-HDMI-A2 [150.525656] Dynamic subtest C-HDMI-A2: SUCCESS (1.227s) [150.526657] Subtest basic-flip-vs-modeset: SUCCESS (4.014s) [150.745956] [111/171] (859s left) kms_flip (basic-flip-vs-wf_vblank) [150.935807] Starting subtest: basic-flip-vs-wf_vblank [150.942276] Starting dynamic subtest: A-HDMI-A2 [152.480499] Dynamic subtest A-HDMI-A2: SUCCESS (1.530s) [152.504890] Starting dynamic subtest: B-HDMI-A2 [153.934361] Dynamic subtest B-HDMI-A2: SUCCESS (1.447s) [153.958879] Starting dynamic subtest: C-HDMI-A2 [155.368799] Dynamic subtest C-HDMI-A2: SUCCESS (1.428s) [155.370097] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.427s) [155.775683] [112/171] (854s left) kms_flip (basic-plain-flip) [155.965732] Starting subtest: basic-plain-flip [155.973217] Starting dynamic subtest: A-HDMI-A2 [157.217530] Dynamic subtest A-HDMI-A2: SUCCESS (1.239s) [157.238878] Starting dynamic subtest: B-HDMI-A2 [158.378675] Dynamic subtest B-HDMI-A2: SUCCESS (1.152s) [158.405936] Starting dynamic subtest: C-HDMI-A2 [159.546331] Dynamic subtest C-HDMI-A2: SUCCESS (1.147s) [159.547393] Subtest basic-plain-flip: SUCCESS (3.581s) [159.949847] [113/171] (850s left) kms_force_connector_basic (force-connector-state) [160.210817] Starting subtest: force-connector-state [161.474791] Subtest force-connector-state: SUCCESS (1.264s) [162.095055] [114/171] (848s left) kms_force_connector_basic (force-edid) [162.346852] Starting subtest: force-edid [162.415614] Subtest force-edid: SUCCESS (0.068s) [162.695109] [115/171] (848s left) kms_force_connector_basic (force-load-detect) [162.944359] Starting subtest: force-load-detect [162.947055] Subtest force-load-detect: SKIP (0.000s) [163.194778] [116/171] (847s left) kms_force_connector_basic (prune-stale-modes) [163.446099] Starting subtest: prune-stale-modes [163.520842] Subtest prune-stale-modes: SUCCESS (0.073s) [163.777810] [117/171] (847s left) kms_frontbuffer_tracking (basic) [164.007904] Starting subtest: basic [166.854305] Subtest basic: SUCCESS (2.842s) [166.961292] [118/171] (843s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [167.194945] Starting subtest: compare-crc-sanitycheck [167.197241] Starting dynamic subtest: pipe-A-HDMI-A-2 [167.781872] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.576s) [167.803946] Starting dynamic subtest: pipe-B-HDMI-A-2 [168.560171] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.770s) [168.584908] Starting dynamic subtest: pipe-C-HDMI-A-2 [169.896147] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.319s) [169.897297] Subtest compare-crc-sanitycheck: SUCCESS (2.702s) [170.095884] [119/171] (840s left) kms_pipe_crc_basic (hang-read-crc) [170.305062] Starting subtest: hang-read-crc [170.310239] Starting dynamic subtest: pipe-A-HDMI-A-2 [171.799770] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.486s) [171.823880] Starting dynamic subtest: pipe-B-HDMI-A-2 [174.022987] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.217s) [174.049360] Starting dynamic subtest: pipe-C-HDMI-A-2 [176.783909] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.753s) [176.785172] Subtest hang-read-crc: SUCCESS (6.476s) [177.049775] [120/171] (833s left) kms_pipe_crc_basic (nonblocking-crc) [177.259653] Starting subtest: nonblocking-crc [177.264394] Starting dynamic subtest: pipe-A-HDMI-A-2 [178.027424] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.763s) [178.050937] Starting dynamic subtest: pipe-B-HDMI-A-2 [179.070294] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.030s) [179.092878] Starting dynamic subtest: pipe-C-HDMI-A-2 [180.379418] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.297s) [180.380557] Subtest nonblocking-crc: SUCCESS (3.119s) [180.559572] [121/171] (830s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [180.771386] Starting subtest: nonblocking-crc-frame-sequence [180.775461] Starting dynamic subtest: pipe-A-HDMI-A-2 [181.513675] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.738s) [181.537875] Starting dynamic subtest: pipe-B-HDMI-A-2 [182.732439] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.206s) [182.754875] Starting dynamic subtest: pipe-C-HDMI-A-2 [183.997311] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.254s) [183.998421] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.227s) [184.208211] [122/171] (826s left) kms_pipe_crc_basic (read-crc) [184.422986] Starting subtest: read-crc [184.428155] Starting dynamic subtest: pipe-A-HDMI-A-2 [185.138647] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.710s) [185.160816] Starting dynamic subtest: pipe-B-HDMI-A-2 [186.330143] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.182s) [186.354898] Starting dynamic subtest: pipe-C-HDMI-A-2 [187.412765] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.072s) [187.413842] Subtest read-crc: SUCCESS (2.990s) [187.651876] [123/171] (823s left) kms_pipe_crc_basic (read-crc-frame-sequence) [187.871590] Starting subtest: read-crc-frame-sequence [187.877357] Starting dynamic subtest: pipe-A-HDMI-A-2 [188.611398] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.734s) [188.636893] Starting dynamic subtest: pipe-B-HDMI-A-2 [189.546027] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.923s) [189.568057] Starting dynamic subtest: pipe-C-HDMI-A-2 [190.950071] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.393s) [190.951216] Subtest read-crc-frame-sequence: SUCCESS (3.078s) [191.146711] [124/171] (819s left) kms_psr (primary_page_flip) [191.281566] Subtest primary_page_flip: SKIP (0.000s) [191.318650] [125/171] (819s left) kms_psr (cursor_plane_move) [191.447910] Subtest cursor_plane_move: SKIP (0.000s) [191.485699] [126/171] (819s left) kms_psr (sprite_plane_onoff) [191.616086] Subtest sprite_plane_onoff: SKIP (0.000s) [191.668629] [127/171] (819s left) kms_psr (primary_mmap_gtt) [191.798224] Subtest primary_mmap_gtt: SKIP (0.000s) [191.851885] [128/171] (819s left) kms_setmode (basic-clone-single-crtc) [191.981407] Starting subtest: basic-clone-single-crtc [191.984739] Subtest basic-clone-single-crtc: SKIP (0.000s) [192.063205] [129/171] (819s left) i915_pm_backlight (basic-brightness) [192.269351] Subtest basic-brightness: SKIP (0.000s) [192.318632] [130/171] (818s left) i915_pm_rpm (basic-pci-d3-state) [194.203211] Starting subtest: basic-pci-d3-state [194.781633] Subtest basic-pci-d3-state: SUCCESS (0.578s) [195.014110] [131/171] (816s left) i915_pm_rpm (basic-rte) [195.141300] Starting subtest: basic-rte [197.391886] Subtest basic-rte: SUCCESS (2.245s) [198.129583] [132/171] (813s left) i915_pm_rps (basic-api) [198.269732] Starting subtest: basic-api [198.279069] Subtest basic-api: SUCCESS (0.009s) [198.361744] [133/171] (812s left) prime_self_import (basic-llseek-bad) [198.490259] Starting subtest: basic-llseek-bad [198.498873] Subtest basic-llseek-bad: SUCCESS (0.008s) [198.578289] [134/171] (812s left) prime_self_import (basic-llseek-size) [198.704371] Starting subtest: basic-llseek-size [198.712602] Subtest basic-llseek-size: SUCCESS (0.008s) [198.794957] [135/171] (812s left) prime_self_import (basic-with_fd_dup) [198.922605] Starting subtest: basic-with_fd_dup [198.932868] Subtest basic-with_fd_dup: SUCCESS (0.010s) [199.011220] [136/171] (812s left) prime_self_import (basic-with_one_bo) [199.137869] Starting subtest: basic-with_one_bo [199.148687] Subtest basic-with_one_bo: SUCCESS (0.010s) [199.217522] [137/171] (812s left) prime_self_import (basic-with_one_bo_two_files) [199.340087] Starting subtest: basic-with_one_bo_two_files [199.343722] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [199.429056] [138/171] (811s left) prime_self_import (basic-with_two_bos) [199.554759] Starting subtest: basic-with_two_bos [199.567150] Subtest basic-with_two_bos: SUCCESS (0.012s) [199.644785] [139/171] (811s left) prime_vgem (basic-fence-flip) [199.802579] Starting subtest: basic-fence-flip [200.320140] Subtest basic-fence-flip: SUCCESS (0.512s) [200.395741] [140/171] (811s left) prime_vgem (basic-fence-mmap) [200.543348] Starting subtest: basic-fence-mmap [200.591286] Subtest basic-fence-mmap: SUCCESS (0.047s) [200.679139] [141/171] (810s left) prime_vgem (basic-fence-read) [200.826360] Starting subtest: basic-fence-read [200.912520] Subtest basic-fence-read: SUCCESS (0.081s) [200.995376] [142/171] (810s left) prime_vgem (basic-gtt) [201.147566] Starting subtest: basic-gtt [201.179113] Subtest basic-gtt: SUCCESS (0.031s) [201.261408] [143/171] (810s left) prime_vgem (basic-read) [201.412749] Starting subtest: basic-read [201.460147] Subtest basic-read: SUCCESS (0.048s) [201.544975] [144/171] (809s left) prime_vgem (basic-write) [201.696227] Starting subtest: basic-write [201.748980] Subtest basic-write: SUCCESS (0.052s) [201.828303] [145/171] (809s left) prime_vgem (basic-userptr) [201.982286] Starting subtest: basic-userptr [202.001297] Subtest basic-userptr: SKIP (0.019s) [202.100290] [146/171] (809s left) vgem_basic (setversion) [202.249899] Starting subtest: setversion [202.252243] Subtest setversion: SUCCESS (0.000s) [202.311421] [147/171] (809s left) vgem_basic (create) [202.449943] Starting subtest: create [202.452964] Subtest create: SUCCESS (0.002s) [202.511141] [148/171] (809s left) vgem_basic (debugfs) [202.649924] Starting subtest: debugfs [202.653029] Subtest debugfs: SUCCESS (0.002s) [202.711313] [149/171] (808s left) vgem_basic (dmabuf-export) [202.849986] Starting subtest: dmabuf-export [202.859121] Subtest dmabuf-export: SUCCESS (0.009s) [202.944944] [150/171] (808s left) vgem_basic (dmabuf-fence) [203.083377] Starting subtest: dmabuf-fence [203.087116] Subtest dmabuf-fence: SUCCESS (0.003s) [203.144947] [151/171] (808s left) vgem_basic (dmabuf-fence-before) [203.287256] Starting subtest: dmabuf-fence-before [203.288305] Subtest dmabuf-fence-before: SUCCESS (0.001s) [203.344643] [152/171] (808s left) vgem_basic (dmabuf-mmap) [203.483951] Starting subtest: dmabuf-mmap [203.516186] Subtest dmabuf-mmap: SUCCESS (0.032s) [203.577929] [153/171] (808s left) vgem_basic (mmap) [203.716409] Starting subtest: mmap [203.738177] Subtest mmap: SUCCESS (0.021s) [203.795069] [154/171] (808s left) vgem_basic (second-client) [203.933347] Starting subtest: second-client [203.982059] Subtest second-client: SUCCESS (0.048s) [204.044781] [155/171] (807s left) vgem_basic (sysfs) [204.183129] Starting subtest: sysfs [204.186159] Subtest sysfs: SUCCESS (0.003s) [204.248141] [156/171] (807s left) core_hotunplug (unbind-rebind) [204.416778] Starting subtest: unbind-rebind [205.897870] Subtest unbind-rebind: SUCCESS (1.480s) [205.961908] [157/171] (805s left) vgem_basic (unload) [206.285933] Starting subtest: unload [235.137727] Subtest unload: SUCCESS (28.851s) [235.258918] [158/171] (776s left) i915_module_load (reload) [235.384717] Starting subtest: reload [238.016937] Subtest reload: SUCCESS (2.629s) [238.072776] [159/171] (773s left) gem_lmem_swapping (basic) [238.422394] Subtest basic: SKIP (0.000s) [238.489409] [160/171] (773s left) gem_lmem_swapping (parallel-random-engines) [238.642267] Subtest parallel-random-engines: SKIP (0.000s) [238.696344] [161/171] (773s left) gem_lmem_swapping (random-engines) [238.833688] Subtest random-engines: SKIP (0.000s) [238.879475] [162/171] (773s left) gem_lmem_swapping (verify-random) [239.015682] Subtest verify-random: SKIP (0.000s) [239.063577] [163/171] (773s left) i915_pm_rpm (module-reload) [241.128952] Starting subtest: module-reload [249.599498] Subtest module-reload: SUCCESS (8.468s) [249.624591] [164/171] (762s left) i915_selftest (live) [249.772123] Starting subtest: live [249.775193] Starting dynamic subtest: sanitycheck [250.720170] Dynamic subtest sanitycheck: SUCCESS (0.944s) [250.733799] Starting dynamic subtest: uncore [251.461153] Dynamic subtest uncore: SUCCESS (0.740s) [251.476082] Starting dynamic subtest: workarounds [252.423300] Dynamic subtest workarounds: SUCCESS (0.961s) [252.439062] Starting dynamic subtest: gt_engines [253.712138] Dynamic subtest gt_engines: SUCCESS (1.287s) [253.726038] Starting dynamic subtest: gt_timelines [265.784479] Dynamic subtest gt_timelines: SUCCESS (12.072s) [265.794234] Starting dynamic subtest: gt_contexts [266.750140] Dynamic subtest gt_contexts: SUCCESS (0.963s) [266.760355] Starting dynamic subtest: gt_lrc [270.317719] Dynamic subtest gt_lrc: SUCCESS (3.565s) [270.328879] Starting dynamic subtest: gt_mocs [271.154142] Dynamic subtest gt_mocs: SUCCESS (0.837s) [271.169882] Starting dynamic subtest: gt_pm [278.976947] Dynamic subtest gt_pm: SUCCESS (7.821s) [278.988994] Starting dynamic subtest: gt_heartbeat [279.898150] Dynamic subtest gt_heartbeat: SUCCESS (0.920s) [279.913985] Starting dynamic subtest: requests [287.180171] Dynamic subtest requests: SUCCESS (7.280s) [287.190755] Starting dynamic subtest: migrate [291.216886] Dynamic subtest migrate: SUCCESS (4.035s) [291.227586] Starting dynamic subtest: active [292.119973] Dynamic subtest active: SUCCESS (0.903s) [292.131998] Starting dynamic subtest: objects [295.218462] Dynamic subtest objects: SUCCESS (3.097s) [295.229146] Starting dynamic subtest: mman [301.754870] Dynamic subtest mman: SUCCESS (6.536s) [301.766525] Starting dynamic subtest: dmabuf [302.555574] Dynamic subtest dmabuf: SUCCESS (0.800s) [302.582100] Starting dynamic subtest: vma [303.362126] Dynamic subtest vma: SUCCESS (0.805s) [303.378892] Starting dynamic subtest: coherency [306.150066] Dynamic subtest coherency: SUCCESS (2.786s) [306.161346] Starting dynamic subtest: gtt [316.379908] Dynamic subtest gtt: SUCCESS (10.228s) [316.390858] Starting dynamic subtest: gem [317.271145] Dynamic subtest gem: SUCCESS (0.891s) [317.287985] Starting dynamic subtest: evict [320.525061] Dynamic subtest evict: SUCCESS (3.253s) [320.536794] Starting dynamic subtest: hugepages [327.206860] Dynamic subtest hugepages: SUCCESS (6.679s) [327.217828] Starting dynamic subtest: gem_contexts [343.919788] Dynamic subtest gem_contexts: SUCCESS (16.712s) [343.930858] Starting dynamic subtest: client [344.753163] Dynamic subtest client: SUCCESS (0.834s) [344.767827] Starting dynamic subtest: gem_migrate [345.659037] Dynamic subtest gem_migrate: SUCCESS (0.905s) [345.674975] Starting dynamic subtest: reset [350.635638] Dynamic subtest reset: SUCCESS (4.976s) [350.648145] Starting dynamic subtest: memory_region [351.402962] Dynamic subtest memory_region: SUCCESS (0.766s) [351.419063] Starting dynamic subtest: hangcheck [375.480922] Dynamic subtest hangcheck: SUCCESS (24.076s) [375.491628] Starting dynamic subtest: execlists [385.138997] Dynamic subtest execlists: SUCCESS (9.657s) [385.150065] Starting dynamic subtest: ring_submission [385.958116] Dynamic subtest ring_submission: SUCCESS (0.819s) [385.974819] Starting dynamic subtest: perf [386.897944] Dynamic subtest perf: SUCCESS (0.939s) [386.913175] Starting dynamic subtest: slpc [387.800243] Dynamic subtest slpc: SUCCESS (0.901s) [387.815936] Starting dynamic subtest: guc [388.604217] Dynamic subtest guc: SUCCESS (0.803s) [388.619847] Starting dynamic subtest: guc_multi_lrc [389.474097] Dynamic subtest guc_multi_lrc: SUCCESS (0.869s) [389.491946] Starting dynamic subtest: guc_hang [390.397119] Dynamic subtest guc_hang: SUCCESS (0.922s) [390.412960] Starting dynamic subtest: late_gt_pm [391.253872] Dynamic subtest late_gt_pm: SUCCESS (0.856s) [391.255062] Subtest live: SUCCESS (141.481s) [391.326813] [165/171] (620s left) dmabuf (all-tests) [391.460595] Starting subtest: all-tests [391.464553] Starting dynamic subtest: sanitycheck [391.483134] Dynamic subtest sanitycheck: SUCCESS (0.019s) [391.497662] Starting dynamic subtest: dma_fence [391.625880] Dynamic subtest dma_fence: SUCCESS (0.141s) [391.636575] Starting dynamic subtest: dma_fence_chain [409.118065] Dynamic subtest dma_fence_chain: SUCCESS (17.489s) [409.137348] Starting dynamic subtest: dma_fence_unwrap [409.145800] Dynamic subtest dma_fence_unwrap: SUCCESS (0.027s) [409.168802] Starting dynamic subtest: dma_resv [409.177379] Dynamic subtest dma_resv: SUCCESS (0.024s) [409.178517] Subtest all-tests: SUCCESS (17.710s) [409.198887] [166/171] (602s left) i915_suspend (basic-s2idle-without-i915) [409.324067] Starting subtest: basic-s2idle-without-i915 [428.554972] Subtest basic-s2idle-without-i915: SUCCESS (4.196s) [434.791867] [167/171] (598s left) i915_suspend (basic-s3-without-i915) [434.925973] Starting subtest: basic-s3-without-i915 [455.082169] Subtest basic-s3-without-i915: SUCCESS (4.485s) [457.942206] [168/171] (593s left) gem_exec_suspend (basic-s0) [458.100059] Starting subtest: basic-S0 [458.101771] Starting dynamic subtest: smem [478.345892] Dynamic subtest smem: SUCCESS (4.627s) [478.346979] Subtest basic-S0: SUCCESS (4.628s) [481.504778] [169/171] (588s left) gem_exec_suspend (basic-s3) [481.643368] Starting subtest: basic-S3 [481.645694] Starting dynamic subtest: smem [503.911155] Dynamic subtest smem: SUCCESS (6.018s) [503.912314] Subtest basic-S3: SUCCESS (6.020s) [507.081435] [170/171] (582s left) kms_chamelium_hpd (common-hpd-after-suspend) [507.480197] Subtest common-hpd-after-suspend: SKIP (0.000s) [507.659350] [171/171] (581s left) kms_pipe_crc_basic (suspend-read-crc) [507.866516] Starting subtest: suspend-read-crc [507.870089] Starting dynamic subtest: pipe-A-HDMI-A-2 [527.273940] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.200s) [527.300340] Starting dynamic subtest: pipe-B-HDMI-A-2 [549.279117] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (4.622s) [549.309229] Starting dynamic subtest: pipe-C-HDMI-A-2 [570.525626] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (5.235s) [570.526713] Subtest suspend-read-crc: SUCCESS (14.077s) [575.680470] Closing watchdogs Done.