[47.257531] Initializing watchdogs [47.257742] /dev/watchdog0 [47.268789] [001/171] (960s left) i915_module_load (load) [47.428993] Starting subtest: load [50.032485] Subtest load: SUCCESS (2.603s) [50.064159] [002/171] (957s left) core_auth (basic-auth) [50.205810] Starting subtest: basic-auth [50.206981] Subtest basic-auth: SUCCESS (0.002s) [50.276517] [003/171] (957s left) debugfs_test (read_all_entries) [50.441220] Starting subtest: read_all_entries [50.514035] Subtest read_all_entries: SUCCESS (0.072s) [50.627122] [004/171] (957s left) debugfs_test (basic-hwmon) [50.767842] Starting subtest: basic-hwmon [50.770031] Subtest basic-hwmon: SKIP (0.000s) [50.880402] [005/171] (956s left) fbdev (eof) [51.046830] Starting subtest: eof [51.049383] Subtest eof: SUCCESS (0.001s) [51.110393] [006/171] (956s left) fbdev (info) [51.245289] Starting subtest: info [51.246565] Subtest info: SUCCESS (0.000s) [51.336162] [007/171] (956s left) fbdev (nullptr) [51.478837] Starting subtest: nullptr [51.480141] Subtest nullptr: SUCCESS (0.000s) [51.544106] [008/171] (956s left) fbdev (read) [51.696725] Starting subtest: read [58.794959] Subtest read: SUCCESS (7.064s) [58.845877] [009/171] (949s left) fbdev (write) [59.013921] Starting subtest: write [62.795617] Subtest write: SUCCESS (3.748s) [62.844216] [010/171] (945s left) gem_basic (bad-close) [62.980138] Starting subtest: bad-close [62.982547] Subtest bad-close: SUCCESS (0.000s) [63.060879] [011/171] (944s left) gem_basic (create-close) [63.197396] Starting subtest: create-close [63.199617] Subtest create-close: SUCCESS (0.000s) [63.294279] [012/171] (944s left) gem_basic (create-fd-close) [63.430539] Starting subtest: create-fd-close [63.432563] Subtest create-fd-close: SUCCESS (0.000s) [63.545031] [013/171] (944s left) gem_busy (busy@all-engines) [63.703708] Starting subtest: busy [63.704872] Starting dynamic subtest: all-engines [63.775561] Dynamic subtest all-engines: SUCCESS (0.072s) [63.776630] Subtest busy: SUCCESS (0.072s) [64.161797] [014/171] (943s left) gem_close_race (basic-process) [64.313947] Starting subtest: basic-process [64.380250] Subtest basic-process: SUCCESS (0.066s) [64.578701] [015/171] (943s left) gem_close_race (basic-threads) [64.735909] Starting subtest: basic-threads [65.916457] Subtest basic-threads: SUCCESS (1.180s) [66.133406] [016/171] (942s left) gem_ctx_create (basic) [66.296025] Starting subtest: basic [66.297229] Subtest basic: SUCCESS (0.000s) [66.495624] [017/171] (941s left) gem_ctx_create (basic-files) [66.648691] Starting subtest: basic-files [68.674544] Subtest basic-files: SUCCESS (2.026s) [68.883647] [018/171] (939s left) gem_ctx_exec (basic) [69.022493] Starting subtest: basic [69.027480] Subtest basic: SUCCESS (0.005s) [69.146674] [019/171] (939s left) gem_exec_basic (basic) [69.300537] Starting subtest: basic [69.301756] Starting dynamic subtest: rcs0-smem [69.302883] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [69.314580] Starting dynamic subtest: bcs0-smem [69.315734] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [69.326398] Starting dynamic subtest: vcs0-smem [69.327612] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [69.338176] Starting dynamic subtest: vecs0-smem [69.339488] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [69.340680] Subtest basic: SUCCESS (0.006s) [69.512177] [020/171] (938s left) gem_exec_create (basic) [69.657576] Starting subtest: basic [69.659030] Starting dynamic subtest: smem [71.707489] Dynamic subtest smem: SUCCESS (2.049s) [71.708661] Subtest basic: SUCCESS (2.049s) [71.928378] [021/171] (936s left) gem_exec_fence (basic-busy) [72.237291] Starting subtest: basic-busy [72.238682] Starting dynamic subtest: rcs0 [72.258048] Dynamic subtest rcs0: SUCCESS (0.028s) [72.270604] Starting dynamic subtest: bcs0 [72.279361] Dynamic subtest bcs0: SUCCESS (0.022s) [72.290491] Starting dynamic subtest: vcs0 [72.305350] Dynamic subtest vcs0: SUCCESS (0.026s) [72.316690] Starting dynamic subtest: vecs0 [72.332406] Dynamic subtest vecs0: SUCCESS (0.027s) [72.333552] Subtest basic-busy: SUCCESS (0.104s) [72.930046] [022/171] (935s left) gem_exec_fence (basic-wait) [73.231122] Starting subtest: basic-wait [73.232622] Starting dynamic subtest: rcs0 [73.257512] Dynamic subtest rcs0: SUCCESS (0.034s) [73.271529] Starting dynamic subtest: bcs0 [73.287505] Dynamic subtest bcs0: SUCCESS (0.030s) [73.300634] Starting dynamic subtest: vcs0 [73.311486] Dynamic subtest vcs0: SUCCESS (0.024s) [73.324395] Starting dynamic subtest: vecs0 [73.339342] Dynamic subtest vecs0: SUCCESS (0.028s) [73.340440] Subtest basic-wait: SUCCESS (0.117s) [73.879991] [023/171] (934s left) gem_exec_fence (basic-await) [74.181575] Starting subtest: basic-await [74.182767] Starting dynamic subtest: rcs0 [74.273299] Dynamic subtest rcs0: SUCCESS (0.098s) [74.300547] Starting dynamic subtest: bcs0 [74.402575] Dynamic subtest bcs0: SUCCESS (0.128s) [74.431493] Starting dynamic subtest: vcs0 [74.533278] Dynamic subtest vcs0: SUCCESS (0.130s) [74.561329] Starting dynamic subtest: vecs0 [74.665140] Dynamic subtest vecs0: SUCCESS (0.130s) [74.666931] Subtest basic-await: SUCCESS (0.490s) [75.263320] [024/171] (933s left) gem_exec_fence (nb-await) [75.562604] Starting subtest: nb-await [75.563803] Starting dynamic subtest: rcs0 [75.621277] Dynamic subtest rcs0: SUCCESS (0.065s) [75.639893] Starting dynamic subtest: bcs0 [75.690869] Dynamic subtest bcs0: SUCCESS (0.070s) [75.719470] Starting dynamic subtest: vcs0 [75.766175] Dynamic subtest vcs0: SUCCESS (0.075s) [75.795652] Starting dynamic subtest: vecs0 [75.842312] Dynamic subtest vecs0: SUCCESS (0.076s) [75.844422] Subtest nb-await: SUCCESS (0.288s) [76.446708] [025/171] (931s left) gem_exec_gttfill (basic) [76.593902] Starting subtest: basic [82.607370] Subtest basic: SUCCESS (6.013s) [82.800065] [026/171] (925s left) gem_exec_parallel (engines) [83.021846] Starting subtest: engines [83.023078] Starting dynamic subtest: basic [85.535366] Dynamic subtest basic: SUCCESS (2.489s) [85.555347] Starting dynamic subtest: contexts [88.990998] Dynamic subtest contexts: SUCCESS (3.471s) [89.004939] Starting dynamic subtest: fds [93.087782] Dynamic subtest fds: SUCCESS (4.104s) [93.117773] Starting dynamic subtest: userptr [95.688870] Dynamic subtest userptr: SUCCESS (2.578s) [95.690377] Subtest engines: SUCCESS (12.643s) [95.880601] [027/171] (912s left) gem_exec_store (basic) [96.026648] Starting subtest: basic [96.083904] Subtest basic: SUCCESS (0.058s) [96.282540] [028/171] (912s left) gem_flink_basic (bad-flink) [96.416550] Starting subtest: bad-flink [96.417783] Subtest bad-flink: SUCCESS (0.000s) [96.498187] [029/171] (911s left) gem_flink_basic (bad-open) [96.634766] Starting subtest: bad-open [96.636063] Subtest bad-open: SUCCESS (0.000s) [96.714608] [030/171] (911s left) gem_flink_basic (basic) [96.851850] Starting subtest: basic [96.853175] Subtest basic: SUCCESS (0.000s) [96.948774] [031/171] (911s left) gem_flink_basic (double-flink) [97.086711] Starting subtest: double-flink [97.087894] Subtest double-flink: SUCCESS (0.000s) [97.182321] [032/171] (911s left) gem_flink_basic (flink-lifetime) [97.320879] Starting subtest: flink-lifetime [97.322117] Subtest flink-lifetime: SUCCESS (0.002s) [97.431459] [033/171] (911s left) gem_huc_copy (huc-copy) [97.573549] Starting subtest: huc-copy [97.575958] Subtest huc-copy: SKIP (0.000s) [97.681327] [034/171] (910s left) gem_linear_blits (basic) [97.965362] Starting subtest: basic [97.977276] Subtest basic: SUCCESS (0.012s) [98.118395] [035/171] (910s left) gem_mmap (basic) [98.316693] Starting subtest: basic [98.321881] Subtest basic: SUCCESS (0.001s) [98.431472] [036/171] (910s left) gem_mmap_gtt (basic) [98.560717] Starting subtest: basic [98.561917] Subtest basic: SUCCESS (0.001s) [98.647736] [037/171] (910s left) gem_render_linear_blits (basic) [98.789223] Starting subtest: basic [98.838522] Subtest basic: SUCCESS (0.050s) [98.897272] [038/171] (909s left) gem_render_tiled_blits (basic) [99.032888] Starting subtest: basic [99.090874] Subtest basic: SUCCESS (0.058s) [99.148317] [039/171] (909s left) gem_ringfill (basic-all) [99.422309] Starting subtest: basic-all [100.655481] Subtest basic-all: SUCCESS (1.224s) [100.733069] [040/171] (908s left) gem_softpin (allocator-basic) [100.871139] Starting subtest: allocator-basic [101.040719] Subtest allocator-basic: SUCCESS (0.161s) [101.165606] [041/171] (907s left) gem_softpin (allocator-basic-reserve) [101.312590] Starting subtest: allocator-basic-reserve [101.484608] Subtest allocator-basic-reserve: SUCCESS (0.163s) [101.582117] [042/171] (907s left) gem_softpin (safe-alignment) [101.741512] Starting subtest: safe-alignment [101.759198] Subtest safe-alignment: SUCCESS (0.019s) [101.881613] [043/171] (907s left) gem_sync (basic-all) [102.028966] Starting subtest: basic-all [104.271359] Subtest basic-all: SUCCESS (2.242s) [104.489062] [044/171] (904s left) gem_sync (basic-each) [104.656831] Starting subtest: basic-each [107.026274] Subtest basic-each: SUCCESS (2.369s) [107.248654] [045/171] (901s left) gem_tiled_blits (basic) [107.541438] Starting subtest: basic [107.570557] Subtest basic: SUCCESS (0.029s) [107.717032] [046/171] (901s left) gem_tiled_fence_blits (basic) [108.077958] Starting subtest: basic [108.105557] Subtest basic: SUCCESS (0.028s) [108.230180] [047/171] (900s left) gem_tiled_pread_basic [108.767162] [048/171] (900s left) gem_wait (busy@all-engines) [108.924396] Starting subtest: busy [108.925723] Starting dynamic subtest: all-engines [109.461770] Dynamic subtest all-engines: SUCCESS (0.537s) [109.463041] Subtest busy: SUCCESS (0.538s) [109.699974] [049/171] (899s left) gem_wait (wait@all-engines) [109.862112] Starting subtest: wait [109.863380] Starting dynamic subtest: all-engines [110.903380] Dynamic subtest all-engines: SUCCESS (1.038s) [110.904440] Subtest wait: SUCCESS (1.039s) [111.150813] [050/171] (897s left) i915_getparams_basic (basic-eu-total) [111.286936] Starting subtest: basic-eu-total [111.289581] Subtest basic-eu-total: SUCCESS (0.000s) [111.365030] [051/171] (897s left) i915_getparams_basic (basic-subslice-total) [111.502240] Starting subtest: basic-subslice-total [111.504543] Subtest basic-subslice-total: SUCCESS (0.000s) [111.581225] [052/171] (897s left) i915_hangman (error-state-basic) [111.725889] Starting subtest: error-state-basic [111.738449] Subtest error-state-basic: SUCCESS (0.011s) [111.832251] [053/171] (897s left) i915_pciid [112.048658] [054/171] (897s left) kms_addfb_basic (addfb25-bad-modifier) [112.180689] Starting subtest: addfb25-bad-modifier [112.181856] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [112.314342] [055/171] (896s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [112.453264] Starting subtest: addfb25-framebuffer-vs-set-tiling [112.454440] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [112.603724] [056/171] (896s left) kms_addfb_basic (addfb25-modifier-no-flag) [112.744258] Starting subtest: addfb25-modifier-no-flag [112.745370] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [112.864334] [057/171] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy) [113.002864] Starting subtest: addfb25-x-tiled-legacy [113.004099] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [113.131574] [058/171] (896s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [113.272601] Starting subtest: addfb25-x-tiled-mismatch-legacy [113.273670] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [113.418426] [059/171] (895s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [113.586260] Starting subtest: addfb25-yf-tiled-legacy [113.587400] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [113.681249] [060/171] (895s left) kms_addfb_basic (addfb25-y-tiled-legacy) [113.852740] Starting subtest: addfb25-y-tiled-legacy [113.853864] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [113.948129] [061/171] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [114.116548] Starting subtest: addfb25-y-tiled-small-legacy [114.117682] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [114.214466] [062/171] (895s left) kms_addfb_basic (bad-pitch-0) [114.352968] Starting subtest: bad-pitch-0 [114.354426] Subtest bad-pitch-0: SUCCESS (0.000s) [114.481298] [063/171] (894s left) kms_addfb_basic (bad-pitch-1024) [114.620327] Starting subtest: bad-pitch-1024 [114.621412] Subtest bad-pitch-1024: SUCCESS (0.000s) [114.748351] [064/171] (894s left) kms_addfb_basic (bad-pitch-128) [114.886584] Starting subtest: bad-pitch-128 [114.887909] Subtest bad-pitch-128: SUCCESS (0.000s) [115.035649] [065/171] (894s left) kms_addfb_basic (bad-pitch-256) [115.174253] Starting subtest: bad-pitch-256 [115.175383] Subtest bad-pitch-256: SUCCESS (0.000s) [115.297768] [066/171] (894s left) kms_addfb_basic (bad-pitch-32) [115.434822] Starting subtest: bad-pitch-32 [115.436104] Subtest bad-pitch-32: SUCCESS (0.000s) [115.564755] [067/171] (894s left) kms_addfb_basic (bad-pitch-63) [115.701268] Starting subtest: bad-pitch-63 [115.702431] Subtest bad-pitch-63: SUCCESS (0.000s) [115.831310] [068/171] (893s left) kms_addfb_basic (bad-pitch-65536) [115.968819] Starting subtest: bad-pitch-65536 [115.969976] Subtest bad-pitch-65536: SUCCESS (0.000s) [116.098699] [069/171] (893s left) kms_addfb_basic (bad-pitch-999) [116.237502] Starting subtest: bad-pitch-999 [116.238598] Subtest bad-pitch-999: SUCCESS (0.000s) [116.365335] [070/171] (893s left) kms_addfb_basic (basic) [116.505154] Starting subtest: basic [116.506236] Subtest basic: SUCCESS (0.000s) [116.631351] [071/171] (893s left) kms_addfb_basic (basic-x-tiled-legacy) [116.764803] Starting subtest: basic-x-tiled-legacy [116.766186] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [116.898953] [072/171] (892s left) kms_addfb_basic (basic-y-tiled-legacy) [117.033228] Starting subtest: basic-y-tiled-legacy [117.034323] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [117.147777] [073/171] (892s left) kms_addfb_basic (bo-too-small) [117.314570] Starting subtest: bo-too-small [117.315818] Subtest bo-too-small: SUCCESS (0.000s) [117.414331] [074/171] (892s left) kms_addfb_basic (bo-too-small-due-to-tiling) [117.583228] Starting subtest: bo-too-small-due-to-tiling [117.584379] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [117.681598] [075/171] (892s left) kms_addfb_basic (clobberred-modifier) [117.816395] Starting subtest: clobberred-modifier [117.817551] Subtest clobberred-modifier: SUCCESS (0.000s) [117.948297] [076/171] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling) [118.101468] Starting subtest: framebuffer-vs-set-tiling [118.102542] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [118.233943] [077/171] (891s left) kms_addfb_basic (invalid-get-prop) [118.391812] Starting subtest: invalid-get-prop [118.392966] Subtest invalid-get-prop: SUCCESS (0.000s) [118.516159] [078/171] (891s left) kms_addfb_basic (invalid-get-prop-any) [118.676939] Starting subtest: invalid-get-prop-any [118.678165] Subtest invalid-get-prop-any: SUCCESS (0.000s) [118.797868] [079/171] (891s left) kms_addfb_basic (invalid-set-prop) [118.950598] Starting subtest: invalid-set-prop [118.951675] Subtest invalid-set-prop: SUCCESS (0.000s) [119.082955] [080/171] (890s left) kms_addfb_basic (invalid-set-prop-any) [119.235528] Starting subtest: invalid-set-prop-any [119.236631] Subtest invalid-set-prop-any: SUCCESS (0.000s) [119.364972] [081/171] (890s left) kms_addfb_basic (no-handle) [119.518900] Starting subtest: no-handle [119.520127] Subtest no-handle: SUCCESS (0.000s) [119.648409] [082/171] (890s left) kms_addfb_basic (size-max) [119.829321] Starting subtest: size-max [119.830494] Subtest size-max: SUCCESS (0.000s) [119.931328] [083/171] (890s left) kms_addfb_basic (small-bo) [120.107499] Starting subtest: small-bo [120.108706] Subtest small-bo: SUCCESS (0.000s) [120.214853] [084/171] (889s left) kms_addfb_basic (tile-pitch-mismatch) [120.369799] Starting subtest: tile-pitch-mismatch [120.370948] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [120.498616] [085/171] (889s left) kms_addfb_basic (too-high) [120.676494] Starting subtest: too-high [120.677748] Subtest too-high: SUCCESS (0.001s) [120.799360] [086/171] (889s left) kms_addfb_basic (too-wide) [120.975488] Starting subtest: too-wide [120.976635] Subtest too-wide: SUCCESS (0.000s) [121.064330] [087/171] (889s left) kms_addfb_basic (unused-handle) [121.218611] Starting subtest: unused-handle [121.219707] Subtest unused-handle: SUCCESS (0.000s) [121.331761] [088/171] (888s left) kms_addfb_basic (unused-modifier) [121.486320] Starting subtest: unused-modifier [121.487388] Subtest unused-modifier: SUCCESS (0.000s) [121.616105] [089/171] (888s left) kms_addfb_basic (unused-offsets) [121.771425] Starting subtest: unused-offsets [121.772516] Subtest unused-offsets: SUCCESS (0.000s) [121.898508] [090/171] (888s left) kms_addfb_basic (unused-pitches) [122.054145] Starting subtest: unused-pitches [122.055362] Subtest unused-pitches: SUCCESS (0.000s) [122.164635] [091/171] (888s left) kms_busy (basic) [122.342093] Starting subtest: basic [122.344543] Starting dynamic subtest: flip [123.449770] Dynamic subtest flip: SUCCESS (1.106s) [123.468678] Starting dynamic subtest: modeset [127.298970] Dynamic subtest modeset: SUCCESS (3.848s) [127.300244] Subtest basic: SUCCESS (4.957s) [128.273124] [092/171] (881s left) kms_chamelium_hpd (dp-hpd-fast) [128.753608] Subtest dp-hpd-fast: SKIP (0.000s) [129.631195] [093/171] (880s left) kms_chamelium_edid (dp-edid-read) [130.107772] Subtest dp-edid-read: SKIP (0.000s) [130.971212] [094/171] (879s left) kms_chamelium_frames (dp-crc-fast) [131.452464] Subtest dp-crc-fast: SKIP (0.000s) [132.316988] [095/171] (878s left) kms_chamelium_hpd (hdmi-hpd-fast) [132.799144] Subtest hdmi-hpd-fast: SKIP (0.000s) [133.658338] [096/171] (876s left) kms_chamelium_edid (hdmi-edid-read) [134.142711] Subtest hdmi-edid-read: SKIP (0.000s) [135.006404] [097/171] (875s left) kms_chamelium_frames (hdmi-crc-fast) [135.486653] Subtest hdmi-crc-fast: SKIP (0.000s) [136.349374] [098/171] (874s left) kms_chamelium_hpd (vga-hpd-fast) [136.829419] Subtest vga-hpd-fast: SKIP (0.000s) [137.695292] [099/171] (872s left) kms_chamelium_edid (vga-edid-read) [138.176510] Subtest vga-edid-read: SKIP (0.000s) [139.038213] [100/171] (871s left) kms_prop_blob (basic) [139.167737] Starting subtest: basic [139.168920] Subtest basic: SUCCESS (0.000s) [139.259903] [101/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [139.427176] Starting subtest: basic-busy-flip-before-cursor-atomic [139.429610] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [139.503381] [102/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [139.668020] Starting subtest: basic-busy-flip-before-cursor-legacy [139.670156] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [139.753965] [103/171] (870s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [139.918132] Starting subtest: basic-flip-after-cursor-atomic [141.185269] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.267s) [142.159404] [104/171] (868s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [142.325360] Starting subtest: basic-flip-after-cursor-legacy [143.603611] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.279s) [144.527908] [105/171] (866s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [144.695342] Starting subtest: basic-flip-after-cursor-varying-size [146.010712] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.311s) [146.959260] [106/171] (863s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [147.124451] Starting subtest: basic-flip-before-cursor-atomic [148.417779] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.293s) [149.393090] [107/171] (861s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [149.559378] Starting subtest: basic-flip-before-cursor-legacy [150.834879] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.276s) [151.761071] [108/171] (858s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [151.928949] Starting subtest: basic-flip-before-cursor-varying-size [153.212387] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.279s) [154.127637] [109/171] (856s left) kms_flip (basic-flip-vs-dpms) [154.265839] Starting subtest: basic-flip-vs-dpms [154.268847] Starting dynamic subtest: A-eDP1 [157.155322] Dynamic subtest A-eDP1: SUCCESS (2.878s) [157.170209] Starting dynamic subtest: B-eDP1 [159.482920] Dynamic subtest B-eDP1: SUCCESS (2.335s) [159.502085] Starting dynamic subtest: C-eDP1 [161.871543] Dynamic subtest C-eDP1: SUCCESS (2.387s) [161.875190] Subtest basic-flip-vs-dpms: SUCCESS (7.611s) [162.776915] [110/171] (848s left) kms_flip (basic-flip-vs-modeset) [162.922464] Starting subtest: basic-flip-vs-modeset [162.925872] Starting dynamic subtest: A-eDP1 [165.766111] Dynamic subtest A-eDP1: SUCCESS (2.838s) [165.782244] Starting dynamic subtest: B-eDP1 [168.138870] Dynamic subtest B-eDP1: SUCCESS (2.370s) [168.154442] Starting dynamic subtest: C-eDP1 [170.496897] Dynamic subtest C-eDP1: SUCCESS (2.360s) [170.504298] Subtest basic-flip-vs-modeset: SUCCESS (7.578s) [171.407816] [111/171] (839s left) kms_flip (basic-flip-vs-wf_vblank) [171.553242] Starting subtest: basic-flip-vs-wf_vblank [171.556940] Starting dynamic subtest: A-eDP1 [173.871354] Dynamic subtest A-eDP1: SUCCESS (2.314s) [173.888963] Starting dynamic subtest: B-eDP1 [176.159239] Dynamic subtest B-eDP1: SUCCESS (2.286s) [176.176418] Starting dynamic subtest: C-eDP1 [178.398715] Dynamic subtest C-eDP1: SUCCESS (2.238s) [178.404912] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.849s) [179.730632] [112/171] (831s left) kms_flip (basic-plain-flip) [179.878197] Starting subtest: basic-plain-flip [179.881697] Starting dynamic subtest: A-eDP1 [181.907140] Dynamic subtest A-eDP1: SUCCESS (2.026s) [181.924722] Starting dynamic subtest: B-eDP1 [183.876491] Dynamic subtest B-eDP1: SUCCESS (1.968s) [183.894498] Starting dynamic subtest: C-eDP1 [185.862727] Dynamic subtest C-eDP1: SUCCESS (1.985s) [185.866948] Subtest basic-plain-flip: SUCCESS (5.990s) [187.154288] [113/171] (823s left) kms_force_connector_basic (force-connector-state) [187.291544] Starting subtest: force-connector-state [189.032673] Subtest force-connector-state: SUCCESS (1.740s) [189.657885] [114/171] (821s left) kms_force_connector_basic (force-edid) [189.804861] Starting subtest: force-edid [190.064819] Subtest force-edid: SUCCESS (0.255s) [190.191296] [115/171] (820s left) kms_force_connector_basic (force-load-detect) [190.338570] Starting subtest: force-load-detect [190.340931] Subtest force-load-detect: SKIP (0.000s) [190.457787] [116/171] (820s left) kms_force_connector_basic (prune-stale-modes) [190.604131] Starting subtest: prune-stale-modes [190.914219] Subtest prune-stale-modes: SUCCESS (0.305s) [191.057565] [117/171] (819s left) kms_frontbuffer_tracking (basic) [191.245397] Starting subtest: basic [194.505370] Subtest basic: SUCCESS (3.260s) [194.626794] [118/171] (816s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [194.791041] Starting subtest: compare-crc-sanitycheck-xr24 [194.794155] Starting dynamic subtest: pipe-A-eDP-1 [195.470749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.676s) [195.491359] Starting dynamic subtest: pipe-B-eDP-1 [196.850998] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.365s) [196.868055] Starting dynamic subtest: pipe-C-eDP-1 [198.393736] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.541s) [198.395180] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.593s) [199.306542] [119/171] (811s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [199.474918] Starting subtest: compare-crc-sanitycheck-nv12 [199.478132] Starting dynamic subtest: pipe-A-eDP-1 [200.407514] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.920s) [200.423635] Starting dynamic subtest: pipe-B-eDP-1 [201.857841] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.455s) [201.884732] Starting dynamic subtest: pipe-C-eDP-1 [203.638408] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.769s) [203.639476] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.156s) [204.556908] [120/171] (806s left) kms_pipe_crc_basic (hang-read-crc) [204.736101] Starting subtest: hang-read-crc [204.739280] Starting dynamic subtest: pipe-A-eDP-1 [207.049252] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.311s) [207.068472] Starting dynamic subtest: pipe-B-eDP-1 [210.039866] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.987s) [210.059523] Starting dynamic subtest: pipe-C-eDP-1 [213.346352] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.301s) [213.347597] Subtest hang-read-crc: SUCCESS (8.610s) [214.282727] [121/171] (796s left) kms_pipe_crc_basic (nonblocking-crc) [214.450574] Starting subtest: nonblocking-crc [214.453732] Starting dynamic subtest: pipe-A-eDP-1 [215.307071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.853s) [215.326892] Starting dynamic subtest: pipe-B-eDP-1 [216.858949] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.547s) [216.878028] Starting dynamic subtest: pipe-C-eDP-1 [218.579041] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.716s) [218.580387] Subtest nonblocking-crc: SUCCESS (4.128s) [219.531429] [122/171] (791s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [219.696671] Starting subtest: nonblocking-crc-frame-sequence [219.697794] Starting dynamic subtest: pipe-A-eDP-1 [220.555966] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.856s) [220.575284] Starting dynamic subtest: pipe-B-eDP-1 [222.107804] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.549s) [222.127397] Starting dynamic subtest: pipe-C-eDP-1 [223.840241] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.729s) [223.841492] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.146s) [224.781135] [123/171] (786s left) kms_pipe_crc_basic (read-crc) [224.951097] Starting subtest: read-crc [224.952343] Starting dynamic subtest: pipe-A-eDP-1 [225.739120] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s) [225.758336] Starting dynamic subtest: pipe-B-eDP-1 [227.224397] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.480s) [227.243992] Starting dynamic subtest: pipe-C-eDP-1 [228.872916] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.645s) [228.874161] Subtest read-crc: SUCCESS (3.924s) [229.834721] [124/171] (781s left) kms_pipe_crc_basic (read-crc-frame-sequence) [230.006616] Starting subtest: read-crc-frame-sequence [230.007815] Starting dynamic subtest: pipe-A-eDP-1 [230.792161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s) [230.811559] Starting dynamic subtest: pipe-B-eDP-1 [232.281707] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s) [232.301424] Starting dynamic subtest: pipe-C-eDP-1 [233.932275] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.647s) [233.933481] Subtest read-crc-frame-sequence: SUCCESS (3.928s) [234.893101] [125/171] (776s left) kms_psr (primary_page_flip) [235.056177] Starting subtest: primary_page_flip [239.326398] Subtest primary_page_flip: SUCCESS (4.257s) [240.266869] [126/171] (771s left) kms_psr (cursor_plane_move) [240.435863] Starting subtest: cursor_plane_move [244.571996] Subtest cursor_plane_move: SUCCESS (4.129s) [245.514647] [127/171] (765s left) kms_psr (sprite_plane_onoff) [245.684672] Starting subtest: sprite_plane_onoff [250.009911] Subtest sprite_plane_onoff: SUCCESS (4.323s) [250.954731] [128/171] (760s left) kms_psr (primary_mmap_gtt) [251.127162] Starting subtest: primary_mmap_gtt [255.367615] Subtest primary_mmap_gtt: SUCCESS (4.230s) [256.274042] [129/171] (755s left) kms_setmode (basic-clone-single-crtc) [256.438426] Starting subtest: basic-clone-single-crtc [256.441725] Subtest basic-clone-single-crtc: SKIP (0.000s) [256.506957] [130/171] (754s left) i915_pm_backlight (basic-brightness) [256.693048] Starting subtest: basic-brightness [256.788304] Starting dynamic subtest: eDP-1 [257.348908] Dynamic subtest eDP-1: SUCCESS (0.559s) [257.350207] Subtest basic-brightness: SUCCESS (0.657s) [258.316122] [131/171] (753s left) i915_pm_rpm (basic-pci-d3-state) [260.203566] Starting subtest: basic-pci-d3-state [264.613759] Subtest basic-pci-d3-state: SUCCESS (4.410s) [264.815438] [132/171] (746s left) i915_pm_rpm (basic-rte) [264.952934] Starting subtest: basic-rte [271.145488] Subtest basic-rte: SUCCESS (6.188s) [276.454153] [133/171] (735s left) i915_pm_rps (basic-api) [276.599370] Starting subtest: basic-api [276.603789] Subtest basic-api: SUCCESS (0.004s) [276.686632] [134/171] (734s left) prime_self_import (basic-llseek-bad) [276.821804] Starting subtest: basic-llseek-bad [276.824483] Subtest basic-llseek-bad: SUCCESS (0.003s) [276.936378] [135/171] (734s left) prime_self_import (basic-llseek-size) [277.070854] Starting subtest: basic-llseek-size [277.075987] Subtest basic-llseek-size: SUCCESS (0.004s) [277.186076] [136/171] (734s left) prime_self_import (basic-with_fd_dup) [277.320659] Starting subtest: basic-with_fd_dup [277.323211] Subtest basic-with_fd_dup: SUCCESS (0.005s) [277.419367] [137/171] (734s left) prime_self_import (basic-with_one_bo) [277.552863] Starting subtest: basic-with_one_bo [277.558210] Subtest basic-with_one_bo: SUCCESS (0.005s) [277.650913] [138/171] (734s left) prime_self_import (basic-with_one_bo_two_files) [277.783691] Starting subtest: basic-with_one_bo_two_files [277.788679] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [277.886079] [139/171] (733s left) prime_self_import (basic-with_two_bos) [278.019248] Starting subtest: basic-with_two_bos [278.024262] Subtest basic-with_two_bos: SUCCESS (0.005s) [278.123941] [140/171] (733s left) prime_vgem (basic-fence-flip) [278.272550] Starting subtest: basic-fence-flip [278.798667] Subtest basic-fence-flip: SUCCESS (0.524s) [278.919776] [141/171] (732s left) prime_vgem (basic-fence-mmap) [279.086887] Starting subtest: basic-fence-mmap [279.134850] Subtest basic-fence-mmap: SUCCESS (0.048s) [279.242072] [142/171] (732s left) prime_vgem (basic-fence-read) [279.406361] Starting subtest: basic-fence-read [279.480636] Subtest basic-fence-read: SUCCESS (0.074s) [279.575454] [143/171] (732s left) prime_vgem (basic-gtt) [279.722370] Starting subtest: basic-gtt [279.746049] Subtest basic-gtt: SUCCESS (0.023s) [279.857729] [144/171] (731s left) prime_vgem (basic-read) [280.005842] Starting subtest: basic-read [280.041716] Subtest basic-read: SUCCESS (0.036s) [280.141930] [145/171] (731s left) prime_vgem (basic-write) [280.288951] Starting subtest: basic-write [280.331391] Subtest basic-write: SUCCESS (0.042s) [280.423024] [146/171] (731s left) vgem_basic (setversion) [280.565466] Starting subtest: setversion [280.567934] Subtest setversion: SUCCESS (0.000s) [280.639446] [147/171] (731s left) vgem_basic (create) [280.781755] Starting subtest: create [280.783139] Subtest create: SUCCESS (0.000s) [280.855728] [148/171] (731s left) vgem_basic (debugfs) [280.997883] Starting subtest: debugfs [280.999332] Subtest debugfs: SUCCESS (0.001s) [281.073053] [149/171] (730s left) vgem_basic (dmabuf-export) [281.215119] Starting subtest: dmabuf-export [281.226776] Subtest dmabuf-export: SUCCESS (0.010s) [281.341830] [150/171] (730s left) vgem_basic (dmabuf-fence) [281.501014] Starting subtest: dmabuf-fence [281.502334] Subtest dmabuf-fence: SUCCESS (0.001s) [281.570246] [151/171] (730s left) vgem_basic (dmabuf-fence-before) [281.716958] Starting subtest: dmabuf-fence-before [281.718179] Subtest dmabuf-fence-before: SUCCESS (0.000s) [281.787131] [152/171] (730s left) vgem_basic (dmabuf-mmap) [281.933367] Starting subtest: dmabuf-mmap [281.958446] Subtest dmabuf-mmap: SUCCESS (0.026s) [282.037028] [153/171] (730s left) vgem_basic (mmap) [282.184042] Starting subtest: mmap [282.199146] Subtest mmap: SUCCESS (0.017s) [282.270050] [154/171] (729s left) vgem_basic (second-client) [282.417614] Starting subtest: second-client [282.450639] Subtest second-client: SUCCESS (0.033s) [282.521305] [155/171] (729s left) vgem_basic (sysfs) [282.665763] Starting subtest: sysfs [282.666924] Subtest sysfs: SUCCESS (0.001s) [282.736855] [156/171] (729s left) core_hotunplug (unbind-rebind) [282.916452] Starting subtest: unbind-rebind [285.367414] Subtest unbind-rebind: SUCCESS (2.452s) [285.406843] [157/171] (726s left) vgem_basic (unload) [285.545864] Starting subtest: unload [314.574074] Subtest unload: SUCCESS (29.018s) [314.708370] [158/171] (697s left) i915_module_load (reload) [314.847141] Starting subtest: reload [318.394721] Subtest reload: SUCCESS (3.548s) [318.427133] [159/171] (693s left) gem_lmem_swapping (basic) [318.584556] Subtest basic: SKIP (0.000s) [318.629822] [160/171] (693s left) gem_lmem_swapping (parallel-random-engines) [318.774344] Subtest parallel-random-engines: SKIP (0.000s) [318.832472] [161/171] (693s left) gem_lmem_swapping (random-engines) [318.978221] Subtest random-engines: SKIP (0.000s) [319.030030] [162/171] (693s left) gem_lmem_swapping (verify-random) [319.176075] Subtest verify-random: SKIP (0.000s) [319.229817] [163/171] (693s left) i915_pm_rpm (module-reload) [331.752291] Starting subtest: module-reload [366.575405] Subtest module-reload: SUCCESS (34.814s) [366.601660] [164/171] (645s left) i915_selftest (live) [366.747504] Starting subtest: live [366.748917] Starting dynamic subtest: sanitycheck [368.634476] Dynamic subtest sanitycheck: SUCCESS (1.877s) [368.649400] Starting dynamic subtest: uncore [370.484636] Dynamic subtest uncore: SUCCESS (1.847s) [370.499469] Starting dynamic subtest: workarounds [372.559488] Dynamic subtest workarounds: SUCCESS (2.072s) [372.574289] Starting dynamic subtest: gt_engines [374.849614] Dynamic subtest gt_engines: SUCCESS (2.287s) [374.864437] Starting dynamic subtest: gt_timelines [387.587615] Dynamic subtest gt_timelines: SUCCESS (12.734s) [387.602514] Starting dynamic subtest: gt_contexts [389.491511] Dynamic subtest gt_contexts: SUCCESS (1.901s) [389.506354] Starting dynamic subtest: gt_lrc [393.901430] Dynamic subtest gt_lrc: SUCCESS (4.406s) [393.916493] Starting dynamic subtest: gt_mocs [395.842623] Dynamic subtest gt_mocs: SUCCESS (1.938s) [395.857097] Starting dynamic subtest: gt_pm [400.966764] Dynamic subtest gt_pm: SUCCESS (5.120s) [400.981631] Starting dynamic subtest: gt_heartbeat [402.927195] Dynamic subtest gt_heartbeat: SUCCESS (1.957s) [402.942661] Starting dynamic subtest: gt_tlb [406.094154] Dynamic subtest gt_tlb: SUCCESS (3.164s) [406.109158] Starting dynamic subtest: requests [413.772361] Dynamic subtest requests: SUCCESS (7.675s) [413.787582] Starting dynamic subtest: migrate [418.383565] Dynamic subtest migrate: SUCCESS (4.609s) [418.398592] Starting dynamic subtest: active [420.266606] Dynamic subtest active: SUCCESS (1.880s) [420.281806] Starting dynamic subtest: objects [423.760312] Dynamic subtest objects: SUCCESS (3.490s) [423.775524] Starting dynamic subtest: mman [430.817474] Dynamic subtest mman: SUCCESS (7.054s) [430.832819] Starting dynamic subtest: dmabuf [432.699543] Dynamic subtest dmabuf: SUCCESS (1.879s) [432.714584] Starting dynamic subtest: vma [434.559510] Dynamic subtest vma: SUCCESS (1.857s) [434.574741] Starting dynamic subtest: coherency [439.111305] Dynamic subtest coherency: SUCCESS (4.549s) [439.126587] Starting dynamic subtest: gtt [448.508736] Dynamic subtest gtt: SUCCESS (9.394s) [448.523785] Starting dynamic subtest: gem [450.500444] Dynamic subtest gem: SUCCESS (1.988s) [450.515559] Starting dynamic subtest: evict [454.390607] Dynamic subtest evict: SUCCESS (3.887s) [454.405625] Starting dynamic subtest: hugepages [462.134963] Dynamic subtest hugepages: SUCCESS (7.740s) [462.150387] Starting dynamic subtest: gem_contexts [477.438598] Dynamic subtest gem_contexts: SUCCESS (15.300s) [477.454333] Starting dynamic subtest: client [479.305767] Dynamic subtest client: SUCCESS (1.864s) [479.321319] Starting dynamic subtest: gem_migrate [481.149718] Dynamic subtest gem_migrate: SUCCESS (1.841s) [481.165329] Starting dynamic subtest: reset [486.572939] Dynamic subtest reset: SUCCESS (5.419s) [486.588541] Starting dynamic subtest: memory_region [488.369998] Dynamic subtest memory_region: SUCCESS (1.793s) [488.386188] Starting dynamic subtest: hangcheck [512.802624] Dynamic subtest hangcheck: SUCCESS (24.429s) [512.818455] Starting dynamic subtest: execlists [522.926872] Dynamic subtest execlists: SUCCESS (10.121s) [522.942479] Starting dynamic subtest: ring_submission [524.716469] Dynamic subtest ring_submission: SUCCESS (1.786s) [524.732294] Starting dynamic subtest: perf [526.658622] Dynamic subtest perf: SUCCESS (1.939s) [526.674494] Starting dynamic subtest: slpc [528.510594] Dynamic subtest slpc: SUCCESS (1.849s) [528.526324] Starting dynamic subtest: guc [530.363710] Dynamic subtest guc: SUCCESS (1.849s) [530.379102] Starting dynamic subtest: guc_multi_lrc [532.210666] Dynamic subtest guc_multi_lrc: SUCCESS (1.843s) [532.226213] Starting dynamic subtest: guc_hang [534.056595] Dynamic subtest guc_hang: SUCCESS (1.842s) [534.072162] Starting dynamic subtest: late_gt_pm [535.929399] Dynamic subtest late_gt_pm: SUCCESS (1.869s) [535.930844] Subtest live: SUCCESS (169.175s) [536.132239] [165/171] (476s left) dmabuf (all-tests) [536.270556] Starting subtest: all-tests [536.273439] Starting dynamic subtest: sanitycheck [536.337975] Dynamic subtest sanitycheck: SUCCESS (0.066s) [536.358084] Starting dynamic subtest: dma_fence [536.527089] Dynamic subtest dma_fence: SUCCESS (0.185s) [536.545859] Starting dynamic subtest: dma_fence_chain [554.243081] Dynamic subtest dma_fence_chain: SUCCESS (17.704s) [554.256227] Starting dynamic subtest: dma_fence_unwrap [554.311938] Dynamic subtest dma_fence_unwrap: SUCCESS (0.073s) [554.331680] Starting dynamic subtest: dma_resv [554.405968] Dynamic subtest dma_resv: SUCCESS (0.090s) [554.408342] Subtest all-tests: SUCCESS (18.137s) [554.440802] [166/171] (458s left) i915_suspend (basic-s2idle-without-i915) [554.569063] Starting subtest: basic-s2idle-without-i915 [577.887764] Subtest basic-s2idle-without-i915: SUCCESS (8.133s) [578.200365] [167/171] (449s left) i915_suspend (basic-s3-without-i915) [578.338413] Starting subtest: basic-s3-without-i915 [601.866280] Subtest basic-s3-without-i915: SUCCESS (6.982s) [602.213664] [168/171] (442s left) gem_exec_suspend (basic-s0) [602.368460] Starting subtest: basic-S0 [602.369869] Starting dynamic subtest: smem [622.263420] Dynamic subtest smem: SUCCESS (3.987s) [622.264780] Subtest basic-S0: SUCCESS (3.989s) [622.476911] [169/171] (437s left) gem_exec_suspend (basic-s3) [622.628980] Starting subtest: basic-S3 [622.630118] Starting dynamic subtest: smem [641.051330] Dynamic subtest smem: SUCCESS (3.676s) [641.052718] Subtest basic-S3: SUCCESS (3.678s) [641.218609] [170/171] (433s left) kms_chamelium_hpd (common-hpd-after-suspend) [641.708177] Subtest common-hpd-after-suspend: SKIP (0.000s) [642.572285] [171/171] (432s left) kms_pipe_crc_basic (suspend-read-crc) [642.737014] Starting subtest: suspend-read-crc [642.738522] Starting dynamic subtest: pipe-A-eDP-1 [660.976406] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.434s) [660.998522] Starting dynamic subtest: pipe-B-eDP-1 [678.940976] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.095s) [678.966005] Starting dynamic subtest: pipe-C-eDP-1 [697.932611] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.238s) [697.933801] Subtest suspend-read-crc: SUCCESS (8.779s) [698.845325] Closing watchdogs Done.