[66.191272] Initializing watchdogs [66.191436] /dev/watchdog0 [66.201962] [001/171] (960s left) i915_module_load (load) [66.343192] Starting subtest: load [69.002732] Subtest load: SUCCESS (2.660s) [69.024579] [002/171] (957s left) core_auth (basic-auth) [69.158938] Starting subtest: basic-auth [69.160165] Subtest basic-auth: SUCCESS (0.001s) [69.245598] [003/171] (957s left) debugfs_test (read_all_entries) [69.374764] Starting subtest: read_all_entries [69.454694] Subtest read_all_entries: SUCCESS (0.079s) [69.548414] [004/171] (957s left) debugfs_test (basic-hwmon) [69.681892] Starting subtest: basic-hwmon [69.684023] Subtest basic-hwmon: SKIP (0.000s) [69.783419] [005/171] (957s left) fbdev (eof) [69.936759] Starting subtest: eof [69.939538] Subtest eof: SUCCESS (0.000s) [70.000842] [006/171] (956s left) fbdev (info) [70.129352] Starting subtest: info [70.130554] Subtest info: SUCCESS (0.000s) [70.205128] [007/171] (956s left) fbdev (nullptr) [70.337457] Starting subtest: nullptr [70.338617] Subtest nullptr: SUCCESS (0.000s) [70.400141] [008/171] (956s left) fbdev (read) [70.536458] Starting subtest: read [77.629901] Subtest read: SUCCESS (7.058s) [77.669384] [009/171] (949s left) fbdev (write) [77.804846] Starting subtest: write [81.548747] Subtest write: SUCCESS (3.735s) [81.616455] [010/171] (945s left) gem_basic (bad-close) [81.740774] Starting subtest: bad-close [81.743171] Subtest bad-close: SUCCESS (0.000s) [81.815526] [011/171] (945s left) gem_basic (create-close) [81.942891] Starting subtest: create-close [81.944924] Subtest create-close: SUCCESS (0.000s) [82.032349] [012/171] (944s left) gem_basic (create-fd-close) [82.159523] Starting subtest: create-fd-close [82.161819] Subtest create-fd-close: SUCCESS (0.000s) [82.266119] [013/171] (944s left) gem_busy (busy@all-engines) [82.410444] Starting subtest: busy [82.411621] Starting dynamic subtest: all-engines [82.464479] Dynamic subtest all-engines: SUCCESS (0.054s) [82.465783] Subtest busy: SUCCESS (0.055s) [82.850818] [014/171] (944s left) gem_close_race (basic-process) [82.997421] Starting subtest: basic-process [83.059604] Subtest basic-process: SUCCESS (0.062s) [83.254259] [015/171] (943s left) gem_close_race (basic-threads) [83.414515] Starting subtest: basic-threads [84.581161] Subtest basic-threads: SUCCESS (1.169s) [84.798307] [016/171] (942s left) gem_ctx_create (basic) [84.941787] Starting subtest: basic [84.943201] Subtest basic: SUCCESS (0.000s) [85.135191] [017/171] (941s left) gem_ctx_create (basic-files) [85.275846] Starting subtest: basic-files [87.296233] Subtest basic-files: SUCCESS (2.020s) [87.522168] [018/171] (939s left) gem_ctx_exec (basic) [87.653338] Starting subtest: basic [87.658147] Subtest basic: SUCCESS (0.005s) [87.767312] [019/171] (939s left) gem_exec_basic (basic) [87.902411] Starting subtest: basic [87.903531] Starting dynamic subtest: rcs0-smem [87.904547] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [87.915565] Starting dynamic subtest: bcs0-smem [87.916764] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [87.926662] Starting dynamic subtest: vcs0-smem [87.927878] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [87.937746] Starting dynamic subtest: vecs0-smem [87.939101] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [87.940382] Subtest basic: SUCCESS (0.005s) [88.100139] [020/171] (939s left) gem_exec_create (basic) [88.232502] Starting subtest: basic [88.233664] Starting dynamic subtest: smem [90.273155] Dynamic subtest smem: SUCCESS (2.040s) [90.274328] Subtest basic: SUCCESS (2.041s) [90.486370] [021/171] (936s left) gem_exec_fence (basic-busy) [90.765771] Starting subtest: basic-busy [90.766965] Starting dynamic subtest: rcs0 [90.779569] Dynamic subtest rcs0: SUCCESS (0.022s) [90.790420] Starting dynamic subtest: bcs0 [90.807997] Dynamic subtest bcs0: SUCCESS (0.028s) [90.818599] Starting dynamic subtest: vcs0 [90.837437] Dynamic subtest vcs0: SUCCESS (0.030s) [90.849300] Starting dynamic subtest: vecs0 [90.875524] Dynamic subtest vecs0: SUCCESS (0.037s) [90.877479] Subtest basic-busy: SUCCESS (0.118s) [91.451167] [022/171] (935s left) gem_exec_fence (basic-wait) [91.744216] Starting subtest: basic-wait [91.745384] Starting dynamic subtest: rcs0 [91.777527] Dynamic subtest rcs0: SUCCESS (0.039s) [91.791396] Starting dynamic subtest: bcs0 [91.813183] Dynamic subtest bcs0: SUCCESS (0.035s) [91.826525] Starting dynamic subtest: vcs0 [91.842541] Dynamic subtest vcs0: SUCCESS (0.030s) [91.853363] Starting dynamic subtest: vecs0 [91.867847] Dynamic subtest vecs0: SUCCESS (0.025s) [91.869354] Subtest basic-wait: SUCCESS (0.130s) [92.384299] [023/171] (934s left) gem_exec_fence (basic-await) [92.667119] Starting subtest: basic-await [92.668232] Starting dynamic subtest: rcs0 [92.748288] Dynamic subtest rcs0: SUCCESS (0.088s) [92.773952] Starting dynamic subtest: bcs0 [92.866784] Dynamic subtest bcs0: SUCCESS (0.117s) [92.893041] Starting dynamic subtest: vcs0 [92.987256] Dynamic subtest vcs0: SUCCESS (0.120s) [93.012545] Starting dynamic subtest: vecs0 [93.106964] Dynamic subtest vecs0: SUCCESS (0.120s) [93.110082] Subtest basic-await: SUCCESS (0.448s) [93.701203] [024/171] (933s left) gem_exec_fence (nb-await) [93.984839] Starting subtest: nb-await [93.986094] Starting dynamic subtest: rcs0 [94.043696] Dynamic subtest rcs0: SUCCESS (0.066s) [94.066256] Starting dynamic subtest: bcs0 [94.115252] Dynamic subtest bcs0: SUCCESS (0.071s) [94.140968] Starting dynamic subtest: vcs0 [94.188310] Dynamic subtest vcs0: SUCCESS (0.073s) [94.214516] Starting dynamic subtest: vecs0 [94.262524] Dynamic subtest vecs0: SUCCESS (0.074s) [94.264676] Subtest nb-await: SUCCESS (0.286s) [94.800775] [025/171] (932s left) gem_exec_gttfill (basic) [94.944724] Starting subtest: basic [102.376295] Subtest basic: SUCCESS (7.423s) [102.552604] [026/171] (924s left) gem_exec_parallel (engines) [102.757237] Starting subtest: engines [102.759341] Starting dynamic subtest: basic [105.129640] Dynamic subtest basic: SUCCESS (2.372s) [105.142210] Starting dynamic subtest: contexts [108.342080] Dynamic subtest contexts: SUCCESS (3.203s) [108.354465] Starting dynamic subtest: fds [112.658847] Dynamic subtest fds: SUCCESS (4.325s) [112.674028] Starting dynamic subtest: userptr [115.169942] Dynamic subtest userptr: SUCCESS (2.511s) [115.171352] Subtest engines: SUCCESS (12.413s) [115.370919] [027/171] (911s left) gem_exec_store (basic) [115.512522] Starting subtest: basic [115.571220] Subtest basic: SUCCESS (0.059s) [115.770165] [028/171] (911s left) gem_flink_basic (bad-flink) [115.894533] Starting subtest: bad-flink [115.895702] Subtest bad-flink: SUCCESS (0.000s) [115.969211] [029/171] (911s left) gem_flink_basic (bad-open) [116.095717] Starting subtest: bad-open [116.096889] Subtest bad-open: SUCCESS (0.000s) [116.168745] [030/171] (911s left) gem_flink_basic (basic) [116.295862] Starting subtest: basic [116.296979] Subtest basic: SUCCESS (0.000s) [116.402599] [031/171] (910s left) gem_flink_basic (double-flink) [116.529784] Starting subtest: double-flink [116.530974] Subtest double-flink: SUCCESS (0.000s) [116.618961] [032/171] (910s left) gem_flink_basic (flink-lifetime) [116.746904] Starting subtest: flink-lifetime [116.748398] Subtest flink-lifetime: SUCCESS (0.002s) [116.835812] [033/171] (910s left) gem_huc_copy (huc-copy) [116.967810] Starting subtest: huc-copy [116.970037] Subtest huc-copy: SKIP (0.000s) [117.069045] [034/171] (910s left) gem_linear_blits (basic) [117.368385] Starting subtest: basic [117.380578] Subtest basic: SUCCESS (0.013s) [117.502532] [035/171] (909s left) gem_mmap (basic) [117.685977] Starting subtest: basic [117.691230] Subtest basic: SUCCESS (0.001s) [117.769827] [036/171] (909s left) gem_mmap_gtt (basic) [117.891930] Starting subtest: basic [117.893254] Subtest basic: SUCCESS (0.001s) [117.969935] [037/171] (909s left) gem_render_linear_blits (basic) [118.100898] Starting subtest: basic [118.153339] Subtest basic: SUCCESS (0.052s) [118.204875] [038/171] (909s left) gem_render_tiled_blits (basic) [118.329230] Starting subtest: basic [118.387478] Subtest basic: SUCCESS (0.058s) [118.457717] [039/171] (909s left) gem_ringfill (basic-all) [118.710860] Starting subtest: basic-all [119.942960] Subtest basic-all: SUCCESS (1.223s) [120.036987] [040/171] (907s left) gem_softpin (allocator-basic) [120.177402] Starting subtest: allocator-basic [120.348256] Subtest allocator-basic: SUCCESS (0.162s) [120.453434] [041/171] (907s left) gem_softpin (allocator-basic-reserve) [120.599800] Starting subtest: allocator-basic-reserve [120.763634] Subtest allocator-basic-reserve: SUCCESS (0.155s) [120.871892] [042/171] (906s left) gem_softpin (safe-alignment) [121.020178] Starting subtest: safe-alignment [121.037720] Subtest safe-alignment: SUCCESS (0.017s) [121.152397] [043/171] (906s left) gem_sync (basic-all) [121.287926] Starting subtest: basic-all [123.794043] Subtest basic-all: SUCCESS (2.481s) [123.972067] [044/171] (903s left) gem_sync (basic-each) [124.120449] Starting subtest: basic-each [126.440258] Subtest basic-each: SUCCESS (2.319s) [126.642639] [045/171] (901s left) gem_tiled_blits (basic) [126.924100] Starting subtest: basic [126.952516] Subtest basic: SUCCESS (0.029s) [127.085485] [046/171] (900s left) gem_tiled_fence_blits (basic) [127.440518] Starting subtest: basic [127.467096] Subtest basic: SUCCESS (0.027s) [127.599270] [047/171] (900s left) gem_tiled_pread_basic [128.121066] [048/171] (899s left) gem_wait (busy@all-engines) [128.260777] Starting subtest: busy [128.261973] Starting dynamic subtest: all-engines [128.778483] Dynamic subtest all-engines: SUCCESS (0.517s) [128.779590] Subtest busy: SUCCESS (0.517s) [129.021204] [049/171] (898s left) gem_wait (wait@all-engines) [129.169415] Starting subtest: wait [129.170596] Starting dynamic subtest: all-engines [130.212372] Dynamic subtest all-engines: SUCCESS (1.039s) [130.213563] Subtest wait: SUCCESS (1.039s) [130.437856] [050/171] (897s left) i915_getparams_basic (basic-eu-total) [130.563622] Starting subtest: basic-eu-total [130.565879] Subtest basic-eu-total: SUCCESS (0.000s) [130.641616] [051/171] (897s left) i915_getparams_basic (basic-subslice-total) [130.768467] Starting subtest: basic-subslice-total [130.770659] Subtest basic-subslice-total: SUCCESS (0.000s) [130.852461] [052/171] (897s left) i915_hangman (error-state-basic) [130.996569] Starting subtest: error-state-basic [131.008436] Subtest error-state-basic: SUCCESS (0.011s) [131.086574] [053/171] (896s left) i915_pciid [131.286060] [054/171] (896s left) kms_addfb_basic (addfb25-bad-modifier) [131.413513] Starting subtest: addfb25-bad-modifier [131.415131] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [131.552295] [055/171] (896s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [131.680207] Starting subtest: addfb25-framebuffer-vs-set-tiling [131.681304] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [131.802704] [056/171] (896s left) kms_addfb_basic (addfb25-modifier-no-flag) [131.947206] Starting subtest: addfb25-modifier-no-flag [131.949858] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [132.052032] [057/171] (895s left) kms_addfb_basic (addfb25-x-tiled-legacy) [132.188600] Starting subtest: addfb25-x-tiled-legacy [132.189675] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [132.302200] [058/171] (895s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [132.453495] Starting subtest: addfb25-x-tiled-mismatch-legacy [132.459712] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [132.552361] [059/171] (895s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [132.705454] Starting subtest: addfb25-yf-tiled-legacy [132.706499] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [132.803487] [060/171] (895s left) kms_addfb_basic (addfb25-y-tiled-legacy) [132.954640] Starting subtest: addfb25-y-tiled-legacy [132.955827] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [133.052286] [061/171] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [133.203964] Starting subtest: addfb25-y-tiled-small-legacy [133.205154] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [133.302400] [062/171] (894s left) kms_addfb_basic (bad-pitch-0) [133.429206] Starting subtest: bad-pitch-0 [133.430321] Subtest bad-pitch-0: SUCCESS (0.000s) [133.553095] [063/171] (894s left) kms_addfb_basic (bad-pitch-1024) [133.683224] Starting subtest: bad-pitch-1024 [133.684386] Subtest bad-pitch-1024: SUCCESS (0.000s) [133.802405] [064/171] (894s left) kms_addfb_basic (bad-pitch-128) [133.926704] Starting subtest: bad-pitch-128 [133.927785] Subtest bad-pitch-128: SUCCESS (0.000s) [134.053187] [065/171] (894s left) kms_addfb_basic (bad-pitch-256) [134.180138] Starting subtest: bad-pitch-256 [134.181229] Subtest bad-pitch-256: SUCCESS (0.000s) [134.303105] [066/171] (893s left) kms_addfb_basic (bad-pitch-32) [134.428989] Starting subtest: bad-pitch-32 [134.430071] Subtest bad-pitch-32: SUCCESS (0.000s) [134.552117] [067/171] (893s left) kms_addfb_basic (bad-pitch-63) [134.681034] Starting subtest: bad-pitch-63 [134.682106] Subtest bad-pitch-63: SUCCESS (0.000s) [134.824301] [068/171] (893s left) kms_addfb_basic (bad-pitch-65536) [134.954423] Starting subtest: bad-pitch-65536 [134.955498] Subtest bad-pitch-65536: SUCCESS (0.000s) [135.087427] [069/171] (893s left) kms_addfb_basic (bad-pitch-999) [135.216670] Starting subtest: bad-pitch-999 [135.217871] Subtest bad-pitch-999: SUCCESS (0.000s) [135.335973] [070/171] (892s left) kms_addfb_basic (basic) [135.462109] Starting subtest: basic [135.463280] Subtest basic: SUCCESS (0.000s) [135.586290] [071/171] (892s left) kms_addfb_basic (basic-x-tiled-legacy) [135.709705] Starting subtest: basic-x-tiled-legacy [135.711100] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [135.835522] [072/171] (892s left) kms_addfb_basic (basic-y-tiled-legacy) [135.963129] Starting subtest: basic-y-tiled-legacy [135.964310] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [136.085597] [073/171] (892s left) kms_addfb_basic (bo-too-small) [136.238035] Starting subtest: bo-too-small [136.239223] Subtest bo-too-small: SUCCESS (0.000s) [136.336194] [074/171] (892s left) kms_addfb_basic (bo-too-small-due-to-tiling) [136.489930] Starting subtest: bo-too-small-due-to-tiling [136.491152] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [136.568747] [075/171] (891s left) kms_addfb_basic (clobberred-modifier) [136.694779] Starting subtest: clobberred-modifier [136.696165] Subtest clobberred-modifier: SUCCESS (0.000s) [136.819392] [076/171] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling) [136.947065] Starting subtest: framebuffer-vs-set-tiling [136.948210] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [137.068622] [077/171] (891s left) kms_addfb_basic (invalid-get-prop) [137.197135] Starting subtest: invalid-get-prop [137.198197] Subtest invalid-get-prop: SUCCESS (0.000s) [137.318944] [078/171] (891s left) kms_addfb_basic (invalid-get-prop-any) [137.445265] Starting subtest: invalid-get-prop-any [137.446361] Subtest invalid-get-prop-any: SUCCESS (0.000s) [137.569409] [079/171] (890s left) kms_addfb_basic (invalid-set-prop) [137.697198] Starting subtest: invalid-set-prop [137.698259] Subtest invalid-set-prop: SUCCESS (0.000s) [137.819324] [080/171] (890s left) kms_addfb_basic (invalid-set-prop-any) [137.948143] Starting subtest: invalid-set-prop-any [137.949219] Subtest invalid-set-prop-any: SUCCESS (0.000s) [138.068689] [081/171] (890s left) kms_addfb_basic (no-handle) [138.196980] Starting subtest: no-handle [138.198188] Subtest no-handle: SUCCESS (0.000s) [138.320778] [082/171] (890s left) kms_addfb_basic (size-max) [138.476403] Starting subtest: size-max [138.477525] Subtest size-max: SUCCESS (0.000s) [138.568924] [083/171] (890s left) kms_addfb_basic (small-bo) [138.725841] Starting subtest: small-bo [138.727050] Subtest small-bo: SUCCESS (0.000s) [138.818608] [084/171] (889s left) kms_addfb_basic (tile-pitch-mismatch) [138.949190] Starting subtest: tile-pitch-mismatch [138.950271] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [139.069046] [085/171] (889s left) kms_addfb_basic (too-high) [139.225670] Starting subtest: too-high [139.226865] Subtest too-high: SUCCESS (0.001s) [139.318870] [086/171] (889s left) kms_addfb_basic (too-wide) [139.476368] Starting subtest: too-wide [139.477485] Subtest too-wide: SUCCESS (0.000s) [139.568837] [087/171] (889s left) kms_addfb_basic (unused-handle) [139.699099] Starting subtest: unused-handle [139.700162] Subtest unused-handle: SUCCESS (0.000s) [139.819398] [088/171] (888s left) kms_addfb_basic (unused-modifier) [139.957425] Starting subtest: unused-modifier [139.958570] Subtest unused-modifier: SUCCESS (0.000s) [140.068722] [089/171] (888s left) kms_addfb_basic (unused-offsets) [140.187366] Starting subtest: unused-offsets [140.188437] Subtest unused-offsets: SUCCESS (0.000s) [140.302118] [090/171] (888s left) kms_addfb_basic (unused-pitches) [140.439429] Starting subtest: unused-pitches [140.440560] Subtest unused-pitches: SUCCESS (0.000s) [140.552513] [091/171] (888s left) kms_busy (basic) [140.727216] Starting subtest: basic [140.729650] Starting dynamic subtest: flip [141.710511] Dynamic subtest flip: SUCCESS (0.982s) [141.726310] Starting dynamic subtest: modeset [145.626454] Dynamic subtest modeset: SUCCESS (3.915s) [145.627579] Subtest basic: SUCCESS (4.899s) [146.592846] [092/171] (882s left) kms_chamelium_hpd (dp-hpd-fast) [147.063324] Subtest dp-hpd-fast: SKIP (0.000s) [147.952320] [093/171] (880s left) kms_chamelium_edid (dp-edid-read) [148.418130] Subtest dp-edid-read: SKIP (0.000s) [149.296411] [094/171] (879s left) kms_chamelium_frames (dp-crc-fast) [149.760680] Subtest dp-crc-fast: SKIP (0.000s) [150.642648] [095/171] (878s left) kms_chamelium_hpd (hdmi-hpd-fast) [151.108911] Subtest hdmi-hpd-fast: SKIP (0.000s) [151.982304] [096/171] (876s left) kms_chamelium_edid (hdmi-edid-read) [152.449683] Subtest hdmi-edid-read: SKIP (0.000s) [153.327204] [097/171] (875s left) kms_chamelium_frames (hdmi-crc-fast) [153.794637] Subtest hdmi-crc-fast: SKIP (0.000s) [154.670661] [098/171] (874s left) kms_chamelium_hpd (vga-hpd-fast) [155.138045] Subtest vga-hpd-fast: SKIP (0.000s) [156.015358] [099/171] (873s left) kms_chamelium_edid (vga-edid-read) [156.480164] Subtest vga-edid-read: SKIP (0.000s) [157.358983] [100/171] (871s left) kms_prop_blob (basic) [157.479344] Starting subtest: basic [157.480475] Subtest basic: SUCCESS (0.000s) [157.561859] [101/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [157.707956] Starting subtest: basic-busy-flip-before-cursor-atomic [157.710237] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [157.788420] [102/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [157.941433] Starting subtest: basic-busy-flip-before-cursor-legacy [157.943693] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [158.021685] [103/171] (871s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [158.177959] Starting subtest: basic-flip-after-cursor-atomic [159.455421] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.278s) [160.413914] [104/171] (868s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [160.560025] Starting subtest: basic-flip-after-cursor-legacy [161.842484] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.282s) [162.784035] [105/171] (866s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [162.938088] Starting subtest: basic-flip-after-cursor-varying-size [164.229950] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.293s) [165.151601] [106/171] (864s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [165.306653] Starting subtest: basic-flip-before-cursor-atomic [166.595883] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.288s) [167.518566] [107/171] (861s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [167.674404] Starting subtest: basic-flip-before-cursor-legacy [168.963419] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.290s) [169.888747] [108/171] (859s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [170.043861] Starting subtest: basic-flip-before-cursor-varying-size [171.323103] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.279s) [172.257524] [109/171] (857s left) kms_flip (basic-flip-vs-dpms) [172.384229] Starting subtest: basic-flip-vs-dpms [172.387205] Starting dynamic subtest: A-eDP1 [175.261864] Dynamic subtest A-eDP1: SUCCESS (2.875s) [175.277911] Starting dynamic subtest: B-eDP1 [177.615474] Dynamic subtest B-eDP1: SUCCESS (2.352s) [177.633725] Starting dynamic subtest: C-eDP1 [180.005088] Dynamic subtest C-eDP1: SUCCESS (2.385s) [180.006260] Subtest basic-flip-vs-dpms: SUCCESS (7.620s) [180.903902] [110/171] (848s left) kms_flip (basic-flip-vs-modeset) [181.037929] Starting subtest: basic-flip-vs-modeset [181.041100] Starting dynamic subtest: A-eDP1 [183.897430] Dynamic subtest A-eDP1: SUCCESS (2.854s) [183.912731] Starting dynamic subtest: B-eDP1 [186.268087] Dynamic subtest B-eDP1: SUCCESS (2.370s) [186.283469] Starting dynamic subtest: C-eDP1 [188.641090] Dynamic subtest C-eDP1: SUCCESS (2.371s) [188.642271] Subtest basic-flip-vs-modeset: SUCCESS (7.603s) [189.599614] [111/171] (839s left) kms_flip (basic-flip-vs-wf_vblank) [189.736426] Starting subtest: basic-flip-vs-wf_vblank [189.739564] Starting dynamic subtest: A-eDP1 [192.066525] Dynamic subtest A-eDP1: SUCCESS (2.327s) [192.082360] Starting dynamic subtest: B-eDP1 [194.353424] Dynamic subtest B-eDP1: SUCCESS (2.286s) [194.370355] Starting dynamic subtest: C-eDP1 [196.593336] Dynamic subtest C-eDP1: SUCCESS (2.240s) [196.595832] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.861s) [197.854646] [112/171] (831s left) kms_flip (basic-plain-flip) [197.991531] Starting subtest: basic-plain-flip [197.994673] Starting dynamic subtest: A-eDP1 [200.038428] Dynamic subtest A-eDP1: SUCCESS (2.044s) [200.054088] Starting dynamic subtest: B-eDP1 [202.003273] Dynamic subtest B-eDP1: SUCCESS (1.964s) [202.019200] Starting dynamic subtest: C-eDP1 [203.990215] Dynamic subtest C-eDP1: SUCCESS (1.986s) [203.992648] Subtest basic-plain-flip: SUCCESS (6.003s) [205.278791] [113/171] (824s left) kms_force_connector_basic (force-connector-state) [205.404499] Starting subtest: force-connector-state [207.094464] Subtest force-connector-state: SUCCESS (1.689s) [207.704830] [114/171] (821s left) kms_force_connector_basic (force-edid) [207.846425] Starting subtest: force-edid [208.098660] Subtest force-edid: SUCCESS (0.253s) [208.220617] [115/171] (821s left) kms_force_connector_basic (force-load-detect) [208.362858] Starting subtest: force-load-detect [208.365356] Subtest force-load-detect: SKIP (0.000s) [208.470918] [116/171] (821s left) kms_force_connector_basic (prune-stale-modes) [208.613636] Starting subtest: prune-stale-modes [208.918374] Subtest prune-stale-modes: SUCCESS (0.304s) [209.020705] [117/171] (820s left) kms_frontbuffer_tracking (basic) [209.187467] Starting subtest: basic [212.520551] Subtest basic: SUCCESS (3.335s) [212.638788] [118/171] (816s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [212.799394] Starting subtest: compare-crc-sanitycheck [212.802283] Starting dynamic subtest: pipe-A-eDP-1 [213.488341] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.683s) [213.503846] Starting dynamic subtest: pipe-B-eDP-1 [214.854209] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.366s) [214.882257] Starting dynamic subtest: pipe-C-eDP-1 [216.412693] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.556s) [216.417975] Subtest compare-crc-sanitycheck: SUCCESS (3.613s) [217.386287] [119/171] (812s left) kms_pipe_crc_basic (hang-read-crc) [217.542474] Starting subtest: hang-read-crc [217.543722] Starting dynamic subtest: pipe-A-eDP-1 [219.852228] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.308s) [219.869221] Starting dynamic subtest: pipe-B-eDP-1 [222.825855] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.971s) [222.843786] Starting dynamic subtest: pipe-C-eDP-1 [226.108408] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.278s) [226.109685] Subtest hang-read-crc: SUCCESS (8.566s) [227.033898] [120/171] (802s left) kms_pipe_crc_basic (nonblocking-crc) [227.191405] Starting subtest: nonblocking-crc [227.192509] Starting dynamic subtest: pipe-A-eDP-1 [228.045903] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.853s) [228.062491] Starting dynamic subtest: pipe-B-eDP-1 [229.598401] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.550s) [229.614616] Starting dynamic subtest: pipe-C-eDP-1 [231.304783] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.702s) [231.305946] Subtest nonblocking-crc: SUCCESS (4.113s) [232.218338] [121/171] (797s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [232.374321] Starting subtest: nonblocking-crc-frame-sequence [232.377494] Starting dynamic subtest: pipe-A-eDP-1 [233.231313] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.855s) [233.248741] Starting dynamic subtest: pipe-B-eDP-1 [234.781999] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.548s) [234.799970] Starting dynamic subtest: pipe-C-eDP-1 [236.487057] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.702s) [236.488373] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.113s) [237.402171] [122/171] (792s left) kms_pipe_crc_basic (read-crc) [237.557549] Starting subtest: read-crc [237.560982] Starting dynamic subtest: pipe-A-eDP-1 [238.346740] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s) [238.362908] Starting dynamic subtest: pipe-B-eDP-1 [239.836419] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.487s) [239.852731] Starting dynamic subtest: pipe-C-eDP-1 [241.475436] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.637s) [241.476556] Subtest read-crc: SUCCESS (3.918s) [242.393995] [123/171] (787s left) kms_pipe_crc_basic (read-crc-frame-sequence) [242.552087] Starting subtest: read-crc-frame-sequence [242.553292] Starting dynamic subtest: pipe-A-eDP-1 [243.338072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s) [243.354021] Starting dynamic subtest: pipe-B-eDP-1 [244.825513] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.486s) [244.843211] Starting dynamic subtest: pipe-C-eDP-1 [246.465514] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.635s) [246.466604] Subtest read-crc-frame-sequence: SUCCESS (3.914s) [247.386315] [124/171] (782s left) kms_psr (primary_page_flip) [247.546194] Starting subtest: primary_page_flip [251.823244] Subtest primary_page_flip: SUCCESS (4.266s) [252.761834] [125/171] (776s left) kms_psr (cursor_plane_move) [252.920131] Starting subtest: cursor_plane_move [257.033389] Subtest cursor_plane_move: SUCCESS (4.107s) [257.946319] [126/171] (771s left) kms_psr (sprite_plane_onoff) [258.105282] Starting subtest: sprite_plane_onoff [262.329836] Subtest sprite_plane_onoff: SUCCESS (4.223s) [263.258267] [127/171] (766s left) kms_psr (primary_mmap_gtt) [263.415778] Starting subtest: primary_mmap_gtt [267.619914] Subtest primary_mmap_gtt: SUCCESS (4.203s) [268.569980] [128/171] (761s left) kms_setmode (basic-clone-single-crtc) [268.692429] Starting subtest: basic-clone-single-crtc [268.695745] Subtest basic-clone-single-crtc: SKIP (0.000s) [268.769791] [129/171] (761s left) i915_pm_backlight (basic-brightness) [268.927190] Starting subtest: basic-brightness [269.045938] Starting dynamic subtest: eDP-1 [269.598411] Dynamic subtest eDP-1: SUCCESS (0.560s) [269.599459] Subtest basic-brightness: SUCCESS (0.671s) [270.554950] [130/171] (759s left) i915_pm_rpm (basic-pci-d3-state) [272.430997] Starting subtest: basic-pci-d3-state [276.795325] Subtest basic-pci-d3-state: SUCCESS (4.364s) [276.990949] [131/171] (752s left) i915_pm_rpm (basic-rte) [277.116477] Starting subtest: basic-rte [283.256902] Subtest basic-rte: SUCCESS (6.138s) [284.720723] [132/171] (745s left) i915_pm_rps (basic-api) [284.847444] Starting subtest: basic-api [284.851571] Subtest basic-api: SUCCESS (0.004s) [284.953146] [133/171] (744s left) prime_self_import (basic-llseek-bad) [285.070328] Starting subtest: basic-llseek-bad [285.073819] Subtest basic-llseek-bad: SUCCESS (0.002s) [285.169336] [134/171] (744s left) prime_self_import (basic-llseek-size) [285.293798] Starting subtest: basic-llseek-size [285.297157] Subtest basic-llseek-size: SUCCESS (0.004s) [285.402944] [135/171] (744s left) prime_self_import (basic-with_fd_dup) [285.527285] Starting subtest: basic-with_fd_dup [285.531260] Subtest basic-with_fd_dup: SUCCESS (0.004s) [285.619287] [136/171] (744s left) prime_self_import (basic-with_one_bo) [285.745061] Starting subtest: basic-with_one_bo [285.750557] Subtest basic-with_one_bo: SUCCESS (0.005s) [285.836403] [137/171] (744s left) prime_self_import (basic-with_one_bo_two_files) [285.962263] Starting subtest: basic-with_one_bo_two_files [285.965993] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [286.069495] [138/171] (744s left) prime_self_import (basic-with_two_bos) [286.196736] Starting subtest: basic-with_two_bos [286.200233] Subtest basic-with_two_bos: SUCCESS (0.004s) [286.302516] [139/171] (743s left) prime_vgem (basic-fence-flip) [286.442409] Starting subtest: basic-fence-flip [286.917103] Subtest basic-fence-flip: SUCCESS (0.475s) [287.037384] [140/171] (743s left) prime_vgem (basic-fence-mmap) [287.176134] Starting subtest: basic-fence-mmap [287.217493] Subtest basic-fence-mmap: SUCCESS (0.041s) [287.320592] [141/171] (742s left) prime_vgem (basic-fence-read) [287.461137] Starting subtest: basic-fence-read [287.526648] Subtest basic-fence-read: SUCCESS (0.067s) [287.603861] [142/171] (742s left) prime_vgem (basic-gtt) [287.742247] Starting subtest: basic-gtt [287.764223] Subtest basic-gtt: SUCCESS (0.022s) [287.869787] [143/171] (742s left) prime_vgem (basic-read) [288.008880] Starting subtest: basic-read [288.043260] Subtest basic-read: SUCCESS (0.034s) [288.157036] [144/171] (742s left) prime_vgem (basic-write) [288.309468] Starting subtest: basic-write [288.350202] Subtest basic-write: SUCCESS (0.040s) [288.440324] [145/171] (741s left) prime_vgem (basic-userptr) [288.597909] Starting subtest: basic-userptr [288.611747] Subtest basic-userptr: SKIP (0.013s) [288.731693] [146/171] (741s left) vgem_basic (setversion) [288.870353] Starting subtest: setversion [288.872725] Subtest setversion: SUCCESS (0.000s) [288.940319] [147/171] (741s left) vgem_basic (create) [289.085318] Starting subtest: create [289.086601] Subtest create: SUCCESS (0.000s) [289.158265] [148/171] (741s left) vgem_basic (debugfs) [289.303504] Starting subtest: debugfs [289.305503] Subtest debugfs: SUCCESS (0.001s) [289.372194] [149/171] (740s left) vgem_basic (dmabuf-export) [289.501425] Starting subtest: dmabuf-export [289.505207] Subtest dmabuf-export: SUCCESS (0.003s) [289.607990] [150/171] (740s left) vgem_basic (dmabuf-fence) [289.736467] Starting subtest: dmabuf-fence [289.737542] Subtest dmabuf-fence: SUCCESS (0.001s) [289.803350] [151/171] (740s left) vgem_basic (dmabuf-fence-before) [289.953561] Starting subtest: dmabuf-fence-before [289.954766] Subtest dmabuf-fence-before: SUCCESS (0.000s) [290.020037] [152/171] (740s left) vgem_basic (dmabuf-mmap) [290.153607] Starting subtest: dmabuf-mmap [290.178078] Subtest dmabuf-mmap: SUCCESS (0.025s) [290.253759] [153/171] (740s left) vgem_basic (mmap) [290.403541] Starting subtest: mmap [290.418555] Subtest mmap: SUCCESS (0.016s) [290.486722] [154/171] (740s left) vgem_basic (second-client) [290.621038] Starting subtest: second-client [290.669741] Subtest second-client: SUCCESS (0.049s) [290.737459] [155/171] (739s left) vgem_basic (sysfs) [290.886960] Starting subtest: sysfs [290.888253] Subtest sysfs: SUCCESS (0.001s) [290.953768] [156/171] (739s left) core_hotunplug (unbind-rebind) [291.119646] Starting subtest: unbind-rebind [293.478098] Subtest unbind-rebind: SUCCESS (2.359s) [293.513422] [157/171] (737s left) vgem_basic (unload) [293.642266] Starting subtest: unload [322.498832] Subtest unload: SUCCESS (28.821s) [322.582749] [158/171] (708s left) i915_module_load (reload) [322.710742] Starting subtest: reload [325.866472] Subtest reload: SUCCESS (3.155s) [325.893289] [159/171] (704s left) gem_lmem_swapping (basic) [326.037449] Subtest basic: SKIP (0.000s) [326.083953] [160/171] (704s left) gem_lmem_swapping (parallel-random-engines) [326.220283] Subtest parallel-random-engines: SKIP (0.000s) [326.272234] [161/171] (704s left) gem_lmem_swapping (random-engines) [326.407494] Subtest random-engines: SKIP (0.000s) [326.450040] [162/171] (704s left) gem_lmem_swapping (verify-random) [326.585386] Subtest verify-random: SKIP (0.000s) [326.634070] [163/171] (704s left) i915_pm_rpm (module-reload) [339.153808] Starting subtest: module-reload [373.495862] Subtest module-reload: SUCCESS (34.339s) [373.514551] [164/171] (657s left) i915_selftest (live) [373.647755] Starting subtest: live [373.649090] Starting dynamic subtest: sanitycheck [375.446566] Dynamic subtest sanitycheck: SUCCESS (1.789s) [375.460866] Starting dynamic subtest: uncore [377.230700] Dynamic subtest uncore: SUCCESS (1.783s) [377.244986] Starting dynamic subtest: workarounds [379.240704] Dynamic subtest workarounds: SUCCESS (2.009s) [379.255177] Starting dynamic subtest: gt_engines [381.475646] Dynamic subtest gt_engines: SUCCESS (2.234s) [381.490137] Starting dynamic subtest: gt_timelines [393.447779] Dynamic subtest gt_timelines: SUCCESS (11.971s) [393.462263] Starting dynamic subtest: gt_contexts [395.349595] Dynamic subtest gt_contexts: SUCCESS (1.901s) [395.363919] Starting dynamic subtest: gt_lrc [399.635651] Dynamic subtest gt_lrc: SUCCESS (4.285s) [399.650146] Starting dynamic subtest: gt_mocs [401.506578] Dynamic subtest gt_mocs: SUCCESS (1.870s) [401.520986] Starting dynamic subtest: gt_pm [406.548629] Dynamic subtest gt_pm: SUCCESS (5.041s) [406.562999] Starting dynamic subtest: gt_heartbeat [408.480335] Dynamic subtest gt_heartbeat: SUCCESS (1.931s) [408.494670] Starting dynamic subtest: requests [415.997712] Dynamic subtest requests: SUCCESS (7.516s) [416.012175] Starting dynamic subtest: migrate [420.548662] Dynamic subtest migrate: SUCCESS (4.552s) [420.563166] Starting dynamic subtest: active [422.341755] Dynamic subtest active: SUCCESS (1.790s) [422.358152] Starting dynamic subtest: objects [425.748631] Dynamic subtest objects: SUCCESS (3.406s) [425.763191] Starting dynamic subtest: mman [432.650670] Dynamic subtest mman: SUCCESS (6.901s) [432.665251] Starting dynamic subtest: dmabuf [434.460641] Dynamic subtest dmabuf: SUCCESS (1.809s) [434.475205] Starting dynamic subtest: vma [436.253982] Dynamic subtest vma: SUCCESS (1.792s) [436.268575] Starting dynamic subtest: coherency [440.591805] Dynamic subtest coherency: SUCCESS (4.337s) [440.606534] Starting dynamic subtest: gtt [451.866768] Dynamic subtest gtt: SUCCESS (11.274s) [451.881355] Starting dynamic subtest: gem [453.733539] Dynamic subtest gem: SUCCESS (1.866s) [453.748274] Starting dynamic subtest: evict [457.368610] Dynamic subtest evict: SUCCESS (3.634s) [457.383281] Starting dynamic subtest: hugepages [464.202745] Dynamic subtest hugepages: SUCCESS (6.833s) [464.217818] Starting dynamic subtest: gem_contexts [479.288514] Dynamic subtest gem_contexts: SUCCESS (15.085s) [479.303577] Starting dynamic subtest: client [481.134609] Dynamic subtest client: SUCCESS (1.845s) [481.149711] Starting dynamic subtest: gem_migrate [482.917539] Dynamic subtest gem_migrate: SUCCESS (1.782s) [482.932632] Starting dynamic subtest: reset [488.312654] Dynamic subtest reset: SUCCESS (5.394s) [488.327848] Starting dynamic subtest: memory_region [490.064565] Dynamic subtest memory_region: SUCCESS (1.751s) [490.079548] Starting dynamic subtest: hangcheck [514.457699] Dynamic subtest hangcheck: SUCCESS (24.392s) [514.472816] Starting dynamic subtest: execlists [524.461691] Dynamic subtest execlists: SUCCESS (10.003s) [524.476908] Starting dynamic subtest: ring_submission [526.225628] Dynamic subtest ring_submission: SUCCESS (1.763s) [526.240686] Starting dynamic subtest: perf [528.090605] Dynamic subtest perf: SUCCESS (1.864s) [528.105691] Starting dynamic subtest: slpc [529.892691] Dynamic subtest slpc: SUCCESS (1.801s) [529.907943] Starting dynamic subtest: guc [531.663662] Dynamic subtest guc: SUCCESS (1.770s) [531.678909] Starting dynamic subtest: guc_multi_lrc [533.399642] Dynamic subtest guc_multi_lrc: SUCCESS (1.735s) [533.414912] Starting dynamic subtest: guc_hang [535.186690] Dynamic subtest guc_hang: SUCCESS (1.786s) [535.201979] Starting dynamic subtest: late_gt_pm [536.979487] Dynamic subtest late_gt_pm: SUCCESS (1.792s) [536.980803] Subtest live: SUCCESS (163.323s) [537.064969] [165/171] (493s left) dmabuf (all-tests) [537.196284] Starting subtest: all-tests [537.197808] Starting dynamic subtest: sanitycheck [537.226956] Dynamic subtest sanitycheck: SUCCESS (0.030s) [537.239673] Starting dynamic subtest: dma_fence [537.360922] Dynamic subtest dma_fence: SUCCESS (0.133s) [537.372820] Starting dynamic subtest: dma_fence_chain [555.041345] Dynamic subtest dma_fence_chain: SUCCESS (17.671s) [555.054407] Starting dynamic subtest: dma_fence_unwrap [555.057935] Dynamic subtest dma_fence_unwrap: SUCCESS (0.024s) [555.072542] Starting dynamic subtest: dma_resv [555.087470] Dynamic subtest dma_resv: SUCCESS (0.029s) [555.088595] Subtest all-tests: SUCCESS (17.892s) [555.112980] [166/171] (475s left) i915_suspend (basic-s2idle-without-i915) [555.229834] Starting subtest: basic-s2idle-without-i915 [578.455553] Subtest basic-s2idle-without-i915: SUCCESS (8.173s) [578.762272] [167/171] (467s left) i915_suspend (basic-s3-without-i915) [578.898346] Starting subtest: basic-s3-without-i915 [602.530156] Subtest basic-s3-without-i915: SUCCESS (6.887s) [602.857909] [168/171] (459s left) gem_exec_suspend (basic-s0) [603.003911] Starting subtest: basic-S0 [603.005328] Starting dynamic subtest: smem [622.486565] Dynamic subtest smem: SUCCESS (3.567s) [622.487590] Subtest basic-S0: SUCCESS (3.567s) [622.641756] [169/171] (455s left) gem_exec_suspend (basic-s3) [622.776933] Starting subtest: basic-S3 [622.778159] Starting dynamic subtest: smem [641.529655] Dynamic subtest smem: SUCCESS (3.508s) [641.530755] Subtest basic-S3: SUCCESS (3.509s) [641.674917] [170/171] (452s left) kms_chamelium_hpd (common-hpd-after-suspend) [642.146405] Subtest common-hpd-after-suspend: SKIP (0.000s) [643.037562] [171/171] (450s left) kms_pipe_crc_basic (suspend-read-crc) [643.188125] Starting subtest: suspend-read-crc [643.191405] Starting dynamic subtest: pipe-A-eDP-1 [660.583641] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.509s) [660.604722] Starting dynamic subtest: pipe-B-eDP-1 [679.495314] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.121s) [679.517126] Starting dynamic subtest: pipe-C-eDP-1 [698.460535] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.227s) [698.461799] Subtest suspend-read-crc: SUCCESS (8.865s) [699.364212] Closing watchdogs Done.