search

pgid69 / bcm63xx-phone

Telephony driver for Broadcom 6358 running OpenWrt
23 stars 18 forks source link

Error with huawei hg556a #2

Closed dotmark closed 9 years ago

dotmark commented 9 years ago

Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.356000] bcm63xx-phone pcm_stop() 2362: RX DMA halted Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.360000] bcm63xx-phone pcm_stop() 2373: Disabling all PCM channels Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.368000] bcm63xx-phone pcm_regs_reset() 1192: pcm_regs_reset() Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.372000] bcm63xx-phone pcm_regs_reset() 1228: PCM_CTRL_REG <- 0x23200101 Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.380000] bcm63xx-phone pcm_dma_tx_descs_reset() 1373: pcm_dma_tx_descs_reset() Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.388000] bcm63xx-phone pcm_pr_stats() 2053: ======= Stats ======= Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.396000] bcm63xx-phone pcm_pr_stats() 2054: rx_errors = 0 Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.400000] bcm63xx-phone pcm_pr_stats() 2055: rx_length_errors = 0 Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.408000] bcm63xx-phone pcm_pr_stats() 2056: rx_empty_errors = 0 Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.416000] bcm63xx-phone pcm_pr_stats() 2057: rx_good = 0 Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.424000] bcm63xx-phone pcm_pr_stats() 2058: rx_bytes = 0 Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.428000] bcm63xx-phone pcm_pr_stats() 2059: tx_errors = 0 Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.436000] bcm63xx-phone pcm_pr_stats() 2060: tx_good = 0 Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.444000] bcm63xx-phone pcm_pr_stats() 2061: tx_bytes = 0 Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.452000] bcm63xx-phone pcm_pr_stats() 2062: cnt_irq_rx = 0 Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.456000] bcm63xx-phone pcm_pr_stats() 2063: cnt_irq_tx = 0 Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.464000] bcm63xx-phone pcm_dma_deinit() 1798: pcm_dma_deinit() Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.472000] bcm63xx-phone pcm_dma_deinit() 1820: Unmapping DMA addresses of TX descs Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.480000] bcm63xx-phone pcm_dma_deinit() 1825: Unmapping DMA addresses of RX descs Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.488000] bcm63xx-phone pcm_dma_deinit() 1872: Freeing memory of RX and TX data buffers Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.496000] bcm63xx-phone pcm_dma_deinit() 1876: Freeing memory for DMA adresses Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.504000] bcm63xx-phone pcm_dma_deinit() 1881: Freeing DMA memory of RX descs Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.512000] bcm63xx-phone pcm_dma_deinit() 1890: Freeing DMA memory of TX descs Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.520000] bcm63xx-phone pcm_regs_deinit() 1259: pcm_regs_deinit() Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.524000] bcm63xx-phone pcm_regs_reset() 1192: pcm_regs_reset() Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.532000] bcm63xx-phone pcm_regs_reset() 1228: PCM_CTRL_REG <- 0x23200101 Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.540000] bcm63xx-phone pcm6358_pll_deinit() 1037: pcm6358_pll_deinit() Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.636000] bcm63xx-phone pcm_release_shared_res() 2001: pcm_release_shared_res() Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.644000] bcm63xx-phone pcm_release_mem_res() 1936: pcm_release_mem_res(addr=0xfffe1a00, size=32) Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.652000] bcm63xx-phone pcm_release_mem_res() 1936: pcm_release_mem_res(addr=0xfffe1900, size=32) Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.660000] bcm63xx-phone pcm_release_mem_res() 1936: pcm_release_mem_res(addr=0xfffe1800, size=256) Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.672000] bcm63xx-phone pcm_release_mem_res() 1936: pcm_release_mem_res(addr=0xfffe1600, size=256) Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.680000] bcm63xx-phone bcm_drv_init() 1590: Unregistering device Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.688000] bcm63xx-phone bcm_wait_queue_deinit() 39: bcm_wait_queue_deinit() Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.696000] bcm63xx-phone bcm_wait_queue_deinit() 39: bcm_wait_queue_deinit() Sun Jun 7 20:30:24 2015 kern.info kernel: [ 366.704000] bcm63xx-phone board_deinit() 622: board_deinit() Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6034.976000] bcm63xx-phone: bcm63xx-phone: v0.1 Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6034.984000] bcm63xx-phone bcm_drv_init() 1439: bcm_drv_init() Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6034.988000] bcm63xx-phone board_init() 561: board_init() Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6034.996000] bcm63xx-phone: CPU is Broadcom 6358 Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.000000] bcm63xx-phone: Board is HW556 Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.004000] bcm63xx-phone board_get_desc() 615: board_get_desc() Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.008000] bcm63xx-phone bcm_drv_init() 1454: Initializing mutex Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.016000] bcm63xx-phone bcm_drv_init() 1457: Initializing RX wait queue Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.024000] bcm63xx-phone bcm_wait_queue_init() 32: bcm_wait_queue_init() Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.032000] bcm63xx-phone bcm_drv_init() 1459: Initializing TX wait queue Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.036000] bcm63xx-phone bcm_wait_queue_init() 32: bcm_wait_queue_init() Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.044000] bcm63xx-phone bcm_drv_init() 1474: Registering device bcm63xx-phone Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.052000] bcm63xx-phone pcm_init() 2482: pcm_init() Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.056000] bcm63xx-phone pcm_init() 2550: Using 25 buffers of 256 bytes for RX Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.064000] bcm63xx-phone pcm_init() 2586: Using 25 buffers of 256 bytes for TX Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.072000] bcm63xx-phone pcm_get_shared_res() 1950: pcm_get_shared_res() Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.080000] bcm63xx-phone pcm_get_mem_res() 1906: pcm_get_mem_res(id=pcm, addr=0xfffe1600, size=256) Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.088000] bcm63xx-phone pcm_get_mem_res() 1906: pcm_get_mem_res(id=pcm_dma, addr=0xfffe1800, size=256) Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.100000] bcm63xx-phone pcm_get_mem_res() 1906: pcm_get_mem_res(id=pcm_dmac, addr=0xfffe1900, size=32) Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.108000] bcm63xx-phone pcm_get_mem_res() 1906: pcm_get_mem_res(id=pcm_dmas, addr=0xfffe1a00, size=32) Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.208000] bcm63xx-phone pcm6358_pll_init() 970: pcm6358_pll_init() Sun Jun 7 22:04:52 2015 kern.info kernel: [ 6035.212000] bcm63xx-phone pcm6358_pll_init() 975: pll_ctrl1=f0010001, pll_ctrl2=53d47, pll_ctrl3=a85 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.256000] bcm63xx-phone pcm6358_pll_init() 1028: pll_ctrl1=20001, pll_ctrl2=8492b, pll_ctrl3=1e1c Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.264000] bcm63xx-phone pcm_regs_init() 1247: pcm_regs_init() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.268000] bcm63xx-phone pcm_regs_reset() 1192: pcm_regs_reset() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.276000] bcm63xx-phone pcm_regs_reset() 1228: PCM_CTRL_REG <- 0x23200101 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.284000] bcm63xx-phone pcm_dma_init() 1502: pcm_dma_init() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.288000] bcm63xx-phone pcm_dma_init() 1535: Allocating 200 bytes of DMA memory for RX descs Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.300000] bcm63xx-phone pcm_dma_init() 1546: 200 bytes of memory allocated, starting at address 0xa2e77000 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.308000] bcm63xx-phone pcm_dma_init() 1552: Allocating 200 bytes of DMA memory for TX descs Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.316000] bcm63xx-phone pcm_dma_init() 1563: 200 bytes of memory allocated, starting at address 0xa2e76000 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.328000] bcm63xx-phone pcm_dma_init() 1571: Allocating 12800 bytes of memory for RX and TX data buffers Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.340000] bcm63xx-phone pcm_dma_init() 1578: 12800 bytes of memory allocated, starting at address 0x82e04000 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.348000] bcm63xx-phone pcm_dma_init() 1604: Allocating 224 bytes of memory for DMA addresses Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.356000] bcm63xx-phone pcm_dma_init() 1611: 224 bytes of memory allocated, starting at address 0x82df0800 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.368000] bcm63xx-phone pcm_dma_init() 1618: Mapping DMA addresses of RX descs Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.376000] bcm63xx-phone pcm_dma_init() 1635: Mapping DMA addresses of TX descs Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.384000] bcm63xx-phone pcm_dma_rx_descs_reset() 1342: pcm_dma_rx_descs_reset() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.392000] bcm63xx-phone pcm_dma_tx_descs_reset() 1373: pcm_dma_tx_descs_reset() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.400000] bcm63xx-phone bcm_drv_init() 1524: t->mm_desc.ioctl_param_off = 0, t->mm_desc.ioctl_param_size = 208 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.408000] bcm63xx-phone bcm_drv_init() 1534: t->mm_desc.rbs[0].rx_ring_buf_desc_off = 208, t->mm_desc.rbs[0].rx_ring_buf_desc_size = 12 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.424000] bcm63xx-phone bcm_drv_init() 1542: t->mm_desc.rbs[0].tx_ring_buf_desc_off = 224, t->mm_desc.rbs[0].tx_ring_buf_desc_size = 12 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.436000] bcm63xx-phone bcm_drv_init() 1534: t->mm_desc.rbs[1].rx_ring_buf_desc_off = 240, t->mm_desc.rbs[1].rx_ring_buf_desc_size = 12 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.448000] bcm63xx-phone bcm_drv_init() 1542: t->mm_desc.rbs[1].tx_ring_buf_desc_off = 256, t->mm_desc.rbs[1].tx_ring_buf_desc_size = 12 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.460000] bcm63xx-phone bcm_drv_init() 1564: 8192 bytes of memory allocated, starting at address 0x82e00000 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.472000] bcm63xx-phone bcm_phone_mgr_init() 850: bcm_phone_mgr_init() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.480000] bcm63xx-phone bcm_phone_mgr_devs_init() 724: bcm_phone_mgr_devs_init() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.488000] bcm63xx-phone phone_device_alloc() 55: phone_device_alloc() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.492000] bcm63xx-phone phone_device_alloc() 84: 2020 bytes of memory allocated, starting at address 0x832d4800 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.504000] bcm63xx-phone phone_dev_le88266_init() 54: phone_dev_le88266_init() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.512000] bcm63xx-phone phone_dev_zarlink_ve880_init() 1948: phone_dev_zarlink_ve880_init() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.520000] bcm63xx-phone bcm_mpi_init() 862: bcm_mpi_init() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.536000] bcm63xx-phone bcm_drv_init() 1584: Freeing mmap buffer used for RX, TX... Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.544000] bcm63xx-phone pcm_deinit() 2684: pcm_deinit() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.548000] bcm63xx-phone pcm_stop() 2321: pcm_stop() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.552000] bcm63xx-phone pcm_dma_stop() 1470: pcm_dma_stop() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.560000] bcm63xx-phone pcm_stop() 2333: Halting TX DMA Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.572000] bcm63xx-phone pcm_stop() 2340: TX DMA halted Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.576000] bcm63xx-phone pcm_stop() 2355: Halting RX DMA Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.588000] bcm63xx-phone pcm_stop() 2362: RX DMA halted Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.592000] bcm63xx-phone pcm_stop() 2373: Disabling all PCM channels Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.600000] bcm63xx-phone pcm_regs_reset() 1192: pcm_regs_reset() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.604000] bcm63xx-phone pcm_regs_reset() 1228: PCM_CTRL_REG <- 0x23200101 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.612000] bcm63xx-phone pcm_dma_tx_descs_reset() 1373: pcm_dma_tx_descs_reset() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.620000] bcm63xx-phone pcm_pr_stats() 2053: ======= Stats ======= Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.628000] bcm63xx-phone pcm_pr_stats() 2054: rx_errors = 0 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.632000] bcm63xx-phone pcm_pr_stats() 2055: rx_length_errors = 0 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.640000] bcm63xx-phone pcm_pr_stats() 2056: rx_empty_errors = 0 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.648000] bcm63xx-phone pcm_pr_stats() 2057: rx_good = 0 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.656000] bcm63xx-phone pcm_pr_stats() 2058: rx_bytes = 0 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.660000] bcm63xx-phone pcm_pr_stats() 2059: tx_errors = 0 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.668000] bcm63xx-phone pcm_pr_stats() 2060: tx_good = 0 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.676000] bcm63xx-phone pcm_pr_stats() 2061: tx_bytes = 0 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.684000] bcm63xx-phone pcm_pr_stats() 2062: cnt_irq_rx = 0 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.688000] bcm63xx-phone pcm_pr_stats() 2063: cnt_irq_tx = 0 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.696000] bcm63xx-phone pcm_dma_deinit() 1798: pcm_dma_deinit() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.704000] bcm63xx-phone pcm_dma_deinit() 1820: Unmapping DMA addresses of TX descs Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.712000] bcm63xx-phone pcm_dma_deinit() 1825: Unmapping DMA addresses of RX descs Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.720000] bcm63xx-phone pcm_dma_deinit() 1872: Freeing memory of RX and TX data buffers Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.728000] bcm63xx-phone pcm_dma_deinit() 1876: Freeing memory for DMA adresses Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.736000] bcm63xx-phone pcm_dma_deinit() 1881: Freeing DMA memory of RX descs Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.744000] bcm63xx-phone pcm_dma_deinit() 1890: Freeing DMA memory of TX descs Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.752000] bcm63xx-phone pcm_regs_deinit() 1259: pcm_regs_deinit() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.756000] bcm63xx-phone pcm_regs_reset() 1192: pcm_regs_reset() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.764000] bcm63xx-phone pcm_regs_reset() 1228: PCM_CTRL_REG <- 0x23200101 Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.772000] bcm63xx-phone pcm6358_pll_deinit() 1037: pcm6358_pll_deinit() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.864000] bcm63xx-phone pcm_release_shared_res() 2001: pcm_release_shared_res() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.872000] bcm63xx-phone pcm_release_mem_res() 1936: pcm_release_mem_res(addr=0xfffe1a00, size=32) Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.880000] bcm63xx-phone pcm_release_mem_res() 1936: pcm_release_mem_res(addr=0xfffe1900, size=32) Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.888000] bcm63xx-phone pcm_release_mem_res() 1936: pcm_release_mem_res(addr=0xfffe1800, size=256) Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.900000] bcm63xx-phone pcm_release_mem_res() 1936: pcm_release_mem_res(addr=0xfffe1600, size=256) Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.908000] bcm63xx-phone bcm_drv_init() 1590: Unregistering device Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.916000] bcm63xx-phone bcm_wait_queue_deinit() 39: bcm_wait_queue_deinit() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.924000] bcm63xx-phone bcm_wait_queue_deinit() 39: bcm_wait_queue_deinit() Sun Jun 7 22:04:53 2015 kern.info kernel: [ 6035.932000] bcm63xx-phone board_deinit() 622: board_deinit()

pgid69 commented 9 years ago

From the traces, it seems that MPI submodule failed to initialize properly : line 916 of mpi.c, call to platform_driver_register() fails without even calling bcm63xx_spi_probe(). Frankly, I don't understand why the kernel does not print any message. I suggest you put more trace messages in function bcm_mpi_init() like printing value of ret after the call to platform_driver_register.

Some questions :

dotmark commented 9 years ago

Thanks for your quick response！

  1. I compile bcm63xx-phone driver with default options.
  2. When the openwrt booted.

modprobe bcm63xx-spi

failed to find a module named bcm63xx-spi

but

logread|grep bcm63xx-spi

Sun Jun 7 20:33:36 2015 kern.info kernel: [ 0.428000] bcm63xx-spi bcm63xx-spi: at 0xfffe0800 (irq 9, FIFOs size 542)

the full log is:

Sun Jun 7 20:33:36 2015 kern.info kernel: [ 0.588000] 8021q: 802.1Q VLAN Support v1.8 Sun Jun 7 20:33:36 2015 kern.info kernel: [ 0.612000] VFS: Mounted root (squashfs filesystem) readonly on device 31:2. Sun Jun 7 20:33:36 2015 kern.info kernel: [ 0.636000] Freeing unused kernel memory: 1300K (8035b000 - 804a0000) Sun Jun 7 20:33:36 2015 user.err kernel: [ 2.456000] init: failed to symlink /tmp -> /var Sun Jun 7 20:33:36 2015 user.info kernel: [ 2.460000] init: Console is alive Sun Jun 7 20:33:36 2015 user.info kernel: [ 2.464000] init: - watchdog - Sun Jun 7 20:33:36 2015 kern.info kernel: [ 5.828000] usbcore: registered new interface driver usbfs Sun Jun 7 20:33:36 2015 kern.info kernel: [ 5.832000] usbcore: registered new interface driver hub Sun Jun 7 20:33:36 2015 kern.info kernel: [ 5.840000] usbcore: registered new device driver usb Sun Jun 7 20:33:36 2015 kern.notice kernel: [ 5.940000] SCSI subsystem initialized Sun Jun 7 20:33:36 2015 kern.info kernel: [ 5.960000] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Sun Jun 7 20:33:36 2015 kern.info kernel: [ 5.972000] ehci-platform: EHCI generic platform driver Sun Jun 7 20:33:36 2015 kern.info kernel: [ 5.980000] ehci-platform ehci-platform: EHCI Host Controller Sun Jun 7 20:33:36 2015 kern.info kernel: [ 5.984000] ehci-platform ehci-platform: new USB bus registered, assigned bus number 1 Sun Jun 7 20:33:36 2015 kern.info kernel: [ 5.992000] ehci-platform ehci-platform: irq 18, io mem 0xfffe1300 Sun Jun 7 20:33:36 2015 kern.info kernel: [ 6.012000] ehci-platform ehci-platform: USB 2.0 started, EHCI 1.00, overcurrent ignored Sun Jun 7 20:33:36 2015 kern.info kernel: [ 6.020000] hub 1-0:1.0: USB hub found Sun Jun 7 20:33:36 2015 kern.info kernel: [ 6.024000] hub 1-0:1.0: 2 ports detected Sun Jun 7 20:33:36 2015 kern.info kernel: [ 6.044000] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Sun Jun 7 20:33:36 2015 kern.info kernel: [ 6.052000] ohci-platform: OHCI generic platform driver Sun Jun 7 20:33:36 2015 kern.info kernel: [ 6.056000] ohci-platform ohci-platform: Generic Platform OHCI controller Sun Jun 7 20:33:36 2015 kern.info kernel: [ 6.064000] ohci-platform ohci-platform: new USB bus registered, assigned bus number 2 Sun Jun 7 20:33:36 2015 kern.info kernel: [ 6.072000] ohci-platform ohci-platform: irq 13, io mem 0xfffe1400 Sun Jun 7 20:33:36 2015 kern.info kernel: [ 6.140000] hub 2-0:1.0: USB hub found Sun Jun 7 20:33:36 2015 kern.info kernel: [ 6.144000] hub 2-0:1.0: 2 ports detected Sun Jun 7 20:33:36 2015 kern.info kernel: [ 6.172000] usbcore: registered new interface driver usb-storage Sun Jun 7 20:33:36 2015 kern.info kernel: [ 6.592000] usb 2-2: new full-speed USB device number 2 using ohci-platform Sun Jun 7 20:33:36 2015 user.info kernel: [ 6.796000] init: - preinit - Sun Jun 7 20:33:36 2015 kern.info kernel: [ 6.804000] usb 2-2: not running at top speed; connect to a high speed hub Sun Jun 7 20:33:36 2015 kern.info kernel: [ 7.028000] hub 2-2:1.0: USB hub found Sun Jun 7 20:33:36 2015 kern.info kernel: [ 7.204000] hub 2-2:1.0: 4 ports detected Sun Jun 7 20:33:36 2015 kern.notice kernel: [ 7.968000] random: procd urandom read with 31 bits of entropy available Sun Jun 7 20:33:36 2015 kern.info kernel: [ 9.788000] eth0: link UP - 100/full - flow control off Sun Jun 7 20:33:36 2015 user.info kernel: [ 11.672000] mount_root: loading kmods from internal overlay Sun Jun 7 20:33:36 2015 kern.notice kernel: [ 12.112000] jffs2: notice: (286) jffs2_build_xattr_subsystem: complete building xattr subsystem, 1 of xdatum (0 unchecked, 0 orphan) and 1 of xref (0 dead, 0 orphan) found. Sun Jun 7 20:33:36 2015 user.info kernel: [ 12.128000] block: attempting to load /tmp/jffs_cfg/upper/etc/config/fstab Sun Jun 7 20:33:36 2015 user.info kernel: [ 12.140000] block: extroot: not configured Sun Jun 7 20:33:36 2015 kern.notice kernel: [ 12.192000] jffs2: notice: (283) jffs2_build_xattr_subsystem: complete building xattr subsystem, 1 of xdatum (0 unchecked, 0 orphan) and 1 of xref (0 dead, 0 orphan) found. Sun Jun 7 20:33:36 2015 user.info kernel: [ 12.208000] mount_root: loading kmods from internal overlay Sun Jun 7 20:33:36 2015 user.info kernel: [ 12.408000] block: attempting to load /tmp/jffs_cfg/upper/etc/config/fstab Sun Jun 7 20:33:36 2015 user.info kernel: [ 12.420000] block: extroot: not configured Sun Jun 7 20:33:36 2015 user.info kernel: [ 12.428000] mount_root: switching to jffs2 overlay Sun Jun 7 20:33:36 2015 user.info kernel: [ 12.500000] procd: - early - Sun Jun 7 20:33:36 2015 user.info kernel: [ 12.504000] procd: - watchdog - Sun Jun 7 20:33:36 2015 kern.info kernel: [ 12.932000] eth0: link DOWN Sun Jun 7 20:33:36 2015 user.info kernel: [ 13.620000] procd: - ubus - Sun Jun 7 20:33:36 2015 user.info kernel: [ 14.648000] procd: - init - Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.024000] NET: Registered protocol family 10 Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.084000] ntfs: driver 2.1.31 [Flags: R/O MODULE]. Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.116000] ip6_tables: (C) 2000-2006 Netfilter Core Team Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.192000] i2c /dev entries driver Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.232000] u32 classifier Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.236000] input device check on Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.240000] Actions configured Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.248000] Mirror/redirect action on Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.272000] nf_conntrack version 0.5.0 (957 buckets, 3828 max) Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.308000] Loading modules backported from Linux version master-2015-03-09-0-g141f155 Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.316000] Backport generated by backports.git backports-20150129-0-gdd4a670 Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.360000] dahdi: Version: 2.10.0.1 Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.368000] dahdi: Telephony Interface Registered on major 196 Sun Jun 7 20:33:36 2015 kern.notice kernel: [ 18.416000] dahdi: Warning: Span DAHDI_DUMMY/1 didn't specify a spantype. Please fix driver! Sun Jun 7 20:33:36 2015 kern.debug kernel: [ 18.424000] dahdi_dummy: Trying to load High Resolution Timer Sun Jun 7 20:33:36 2015 kern.debug kernel: [ 18.424000] dahdi_dummy: Initialized High Resolution Timer Sun Jun 7 20:33:36 2015 kern.debug kernel: [ 18.424000] dahdi_dummy: Starting High Resolution Timer Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.424000] dahdi_dummy: High Resolution Timer started, good to go Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.440000] dahdi_echocan_oslec: Registered echo canceler 'OSLEC' Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.452000] dahdi_hfcs: HFC-S PCI A ISDN (V1.42) loading Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.456000] dahdi_hfcs: Check /var/log/kern-debug.log for debugging output level 0. Sun Jun 7 20:33:36 2015 kern.debug kernel: [ 18.464000] dahdi_hfcs: base.c is debugging.<6>[ 18.476000] ip_tables: (C) 2000-2006 Netfilter Core Team Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.632000] usbcore: registered new interface driver ums-alauda Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.640000] usbcore: registered new interface driver ums-cypress Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.652000] usbcore: registered new interface driver ums-datafab Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.664000] usbcore: registered new interface driver ums-freecom Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.676000] usbcore: registered new interface driver ums-isd200 Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.692000] usbcore: registered new interface driver ums-jumpshot Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.700000] usbcore: registered new interface driver ums-karma Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.716000] usbcore: registered new interface driver ums-sddr09 Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.732000] usbcore: registered new interface driver ums-sddr55 Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.748000] usbcore: registered new interface driver ums-usbat Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.764000] usbcore: registered new interface driver usblp Sun Jun 7 20:33:36 2015 kern.info kernel: [ 18.952000] xt_time: kernel timezone is -0000 Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.036000] cfg80211: Calling CRDA to update world regulatory domain Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.124000] cfg80211: World regulatory domain updated: Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.128000] cfg80211: DFS Master region: unset Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.132000] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp), (dfs_cac_time) Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.144000] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.152000] cfg80211: (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A) Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.160000] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm), (N/A) Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.168000] cfg80211: (5170000 KHz - 5250000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.176000] cfg80211: (5250000 KHz - 5330000 KHz @ 80000 KHz, 160000 KHz AUTO), (N/A, 2000 mBm), (0 s) Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.184000] cfg80211: (5490000 KHz - 5730000 KHz @ 160000 KHz), (N/A, 2000 mBm), (0 s) Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.192000] cfg80211: (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A) Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.200000] cfg80211: (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm), (N/A) Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.344000] PPP generic driver version 2.4.2 Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.352000] NET: Registered protocol family 24 Sun Jun 7 20:33:36 2015 kern.warn kernel: [ 19.440000] PCI: Enabling device 0000:00:01.0 (0000 -> 0002) Sun Jun 7 20:33:36 2015 kern.err kernel: [ 19.448000] rt2800pci 0000:00:01.0: failed to load eeprom property Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.452000] ieee80211 phy0: rt2x00lib_request_eeprom_file: Info - Loading EEPROM data from 'rt2x00.eeprom'. Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.464000] ieee80211 phy0: rt2x00_set_rt: Info - RT chipset 3572, rev 0223 detected Sun Jun 7 20:33:36 2015 kern.info kernel: [ 19.472000] ieee80211 phy0: rt2x00_set_rf: Info - RF chipset 0008 detected Sun Jun 7 20:33:36 2015 kern.debug kernel: [ 19.484000] ieee80211 phy0: Selected rate control algorithm 'minstrel_ht' Sun Jun 7 20:33:36 2015 kern.notice kernel: [ 21.536000] random: nonblocking pool is initialized Sun Jun 7 20:33:38 2015 kern.info kernel: [ 26.360000] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready Sun Jun 7 20:33:38 2015 kern.info kernel: [ 26.540000] eth0: link UP - 100/full - flow control off Sun Jun 7 20:33:38 2015 kern.info kernel: [ 26.548000] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Sun Jun 7 20:33:41 2015 user.emerg syslog: this file has been obseleted. please call "/sbin/block mount" directly Sun Jun 7 20:33:41 2015 daemon.err block: /dev/mtdblock3 is already mounted Sun Jun 7 20:33:44 2015 authpriv.info dropbear[930]: Not backgrounding Sun Jun 7 20:33:47 2015 daemon.err insmod: module is already loaded - xt_multiport Sun Jun 7 20:33:47 2015 daemon.err insmod: module is already loaded - xt_comment Sun Jun 7 20:33:47 2015 daemon.err insmod: module is already loaded - xt_length Sun Jun 7 20:33:50 2015 kern.info kernel: [ 37.588000] device eth0.1 entered promiscuous mode Sun Jun 7 20:33:50 2015 kern.info kernel: [ 37.592000] device eth0 entered promiscuous mode Sun Jun 7 20:33:50 2015 kern.info kernel: [ 37.624000] br-lan: port 1(eth0.1) entered forwarding state Sun Jun 7 20:33:50 2015 kern.info kernel: [ 37.632000] br-lan: port 1(eth0.1) entered forwarding state Sun Jun 7 20:33:50 2015 daemon.notice netifd: Interface 'lan' is enabled Sun Jun 7 20:33:50 2015 daemon.notice netifd: Interface 'lan' is setting up now Sun Jun 7 20:33:50 2015 kern.info kernel: [ 37.664000] eth0: link UP - 100/full - flow control off Sun Jun 7 20:33:50 2015 daemon.notice netifd: Interface 'lan' is now up Sun Jun 7 20:33:50 2015 daemon.notice netifd: Interface 'loopback' is enabled Sun Jun 7 20:33:50 2015 daemon.notice netifd: Interface 'loopback' is setting up now Sun Jun 7 20:33:50 2015 daemon.notice netifd: Interface 'loopback' is now up Sun Jun 7 20:33:50 2015 daemon.notice netifd: Network device 'eth0' link is up Sun Jun 7 20:33:50 2015 daemon.notice netifd: VLAN 'eth0.1' link is up Sun Jun 7 20:33:50 2015 daemon.notice netifd: Bridge 'br-lan' link is up Sun Jun 7 20:33:50 2015 daemon.notice netifd: Interface 'lan' has link connectivity Sun Jun 7 20:33:50 2015 daemon.notice netifd: Network device 'lo' link is up Sun Jun 7 20:33:50 2015 daemon.notice netifd: Interface 'loopback' has link connectivity Sun Jun 7 20:33:52 2015 kern.info kernel: [ 39.636000] br-lan: port 1(eth0.1) entered forwarding state Sun Jun 7 20:33:52 2015 daemon.err insmod: module is already loaded - xt_multiport Sun Jun 7 20:33:53 2015 daemon.err insmod: module is already loaded - xt_comment Sun Jun 7 20:33:53 2015 daemon.err insmod: module is already loaded - xt_length Sun Jun 7 20:33:53 2015 user.notice firewall: Reloading firewall due to ifup of lan (br-lan) Sun Jun 7 20:33:55 2015 daemon.notice netifd: radio0 (1063): Configuration file: /var/run/hostapd-phy0.conf Sun Jun 7 20:33:55 2015 kern.info kernel: [ 43.288000] ieee80211 phy0: rt2x00lib_request_firmware: Info - Loading firmware file 'rt2860.bin' Sun Jun 7 20:33:55 2015 kern.info kernel: [ 43.312000] ieee80211 phy0: rt2x00lib_request_firmware: Info - Firmware detected - version: 0.34 Sun Jun 7 20:33:55 2015 kern.info kernel: [ 43.432000] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready Sun Jun 7 20:33:55 2015 kern.info kernel: [ 43.472000] device wlan0 entered promiscuous mode Sun Jun 7 20:33:55 2015 kern.info kernel: [ 43.476000] br-lan: port 2(wlan0) entered forwarding state Sun Jun 7 20:33:55 2015 kern.info kernel: [ 43.484000] br-lan: port 2(wlan0) entered forwarding state Sun Jun 7 20:33:55 2015 kern.info kernel: [ 43.496000] br-lan: port 2(wlan0) entered disabled state Sun Jun 7 20:33:55 2015 daemon.notice netifd: radio0 (1063): wlan0: interface state UNINITIALIZED->COUNTRY_UPDATE Sun Jun 7 20:33:55 2015 daemon.notice netifd: radio0 (1063): Using interface wlan0 with hwaddr 00:0c:43:30:62:01 and ssid "Hello2" Sun Jun 7 20:33:58 2015 kern.info kernel: [ 45.568000] br-lan: port 2(wlan0) entered forwarding state Sun Jun 7 20:33:58 2015 kern.info kernel: [ 45.572000] br-lan: port 2(wlan0) entered forwarding state Sun Jun 7 20:33:58 2015 kern.info kernel: [ 45.580000] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready Sun Jun 7 20:33:58 2015 daemon.notice netifd: radio0 (1063): wlan0: interface state COUNTRY_UPDATE->ENABLED Sun Jun 7 20:33:58 2015 daemon.notice netifd: radio0 (1063): wlan0: AP-ENABLED Sun Jun 7 20:33:58 2015 daemon.notice netifd: Network device 'wlan0' link is up Sun Jun 7 20:34:00 2015 kern.info kernel: [ 47.576000] br-lan: port 2(wlan0) entered forwarding state Sun Jun 7 20:34:03 2015 daemon.info dnsmasq[1359]: started, version 2.73rc8 cachesize 150 Sun Jun 7 20:34:03 2015 daemon.info dnsmasq[1359]: compile time options: IPv6 GNU-getopt no-DBus no-i18n no-IDN DHCP no-DHCPv6 no-Lua TFTP no-conntrack no-ipset no-auth no-DNSSEC loop-detect inotify Sun Jun 7 20:34:03 2015 daemon.info dnsmasq[1359]: DNS service limited to local subnets Sun Jun 7 20:34:03 2015 daemon.info dnsmasq-dhcp[1359]: DHCP, IP range 196.1.2.150 -- 196.1.2.169, lease time 12h Sun Jun 7 20:34:03 2015 daemon.info dnsmasq[1359]: using local addresses only for domain lan Sun Jun 7 20:34:03 2015 daemon.warn dnsmasq[1359]: no servers found in /tmp/resolv.conf.auto, will retry Sun Jun 7 20:34:03 2015 daemon.info dnsmasq[1359]: read /etc/hosts - 1 addresses Sun Jun 7 20:34:03 2015 daemon.info dnsmasq[1359]: read /tmp/hosts/dhcp - 1 addresses Sun Jun 7 20:34:03 2015 daemon.info dnsmasq-dhcp[1359]: read /etc/ethers - 0 addresses Sun Jun 7 20:34:03 2015 user.emerg syslog: setting up led LAN Sun Jun 7 20:34:03 2015 user.emerg syslog: setting up led USB Sun Jun 7 20:34:04 2015 daemon.info hostapd: wlan0: STA e0:f8:47:2d:28:08 IEEE 802.11: authenticated Sun Jun 7 20:34:04 2015 daemon.info hostapd: wlan0: STA e0:f8:47:2d:28:08 IEEE 802.11: associated (aid 1) Sun Jun 7 20:34:04 2015 daemon.info hostapd: wlan0: STA e0:f8:47:2d:28:08 WPA: pairwise key handshake completed (RSN) Sun Jun 7 20:34:06 2015 daemon.info dnsmasq-dhcp[1359]: DHCPREQUEST(br-lan) 196.1.2.154 e0:f8:47:2d:28:08 Sun Jun 7 20:34:06 2015 daemon.info dnsmasq-dhcp[1359]: DHCPACK(br-lan) 196.1.2.154 e0:f8:47:2d:28:08 dotmarkdeMBP Sun Jun 7 20:34:09 2015 daemon.info procd: - init complete - Sun Jun 7 20:34:10 2015 authpriv.info dropbear[1459]: Child connection from 196.1.2.154:56212 Sun Jun 7 20:34:30 2015 authpriv.notice dropbear[1459]: Password auth succeeded for 'root' from 196.1.2.154:56212 Sun Jun 7 20:43:57 2015 daemon.info hostapd: wlan0: STA e0:f8:47:2d:28:08 WPA: group key handshake completed (RSN) Sun Jun 7 20:49:56 2015 daemon.warn odhcpd[891]: DHCPV6 SOLICIT IA_NA from 000100011b18e0c294de80bc7056 on br-lan: ok fd55:c38e:b22f::bcc/128 Sun Jun 7 20:49:56 2015 daemon.info dnsmasq[1359]: read /etc/hosts - 1 addresses Sun Jun 7 20:49:56 2015 daemon.info dnsmasq[1359]: read /tmp/hosts/odhcpd - 0 addresses Sun Jun 7 20:49:56 2015 daemon.info dnsmasq[1359]: read /tmp/hosts/dhcp - 1 addresses Sun Jun 7 20:49:56 2015 daemon.info dnsmasq-dhcp[1359]: read /etc/ethers - 0 addresses Sun Jun 7 20:49:57 2015 daemon.warn odhcpd[891]: DHCPV6 REQUEST IA_NA from 000100011b18e0c294de80bc7056 on br-lan: ok fd55:c38e:b22f::bcc/128 Sun Jun 7 20:49:57 2015 daemon.info dnsmasq[1359]: read /etc/hosts - 1 addresses Sun Jun 7 20:49:57 2015 daemon.info dnsmasq[1359]: read /tmp/hosts/odhcpd - 1 addresses Sun Jun 7 20:49:57 2015 daemon.info dnsmasq[1359]: read /tmp/hosts/dhcp - 1 addresses Sun Jun 7 20:49:57 2015 daemon.info dnsmasq-dhcp[1359]: read /etc/ethers - 0 addresses Sun Jun 7 20:53:57 2015 daemon.info hostapd: wlan0: STA e0:f8:47:2d:28:08 WPA: group key handshake completed (RSN)

pgid69 commented 9 years ago

Ok, there's a conflict with bcm63xx-spi driver. I make my tests with OpenWrt 12.09 where you can choose the way driver bcm63xx-spi is included in the kernel. With OpenWrt 14.07 you have no choice : bcm63xx-spi is always included in the kernel. So if it's possible, i will try to add an option to bcm63xx-phone, to tell it to unregister bcm63xx-spi driver.

pgid69 commented 9 years ago

I wrote a small patch to resolve your problem. I will test it this evening if i can. If you want, here's the content of the patch. After applying it, recompile bcm63xx-phone driver and load it with parameter unregister_bcm63xx_spi=y

From bc2e9d483c018b012d1cbf98f1ae20a5164772a2 Mon Sep 17 00:00:00 2001
From: Gilles Mazoyer <mazoyer.gilles@omega.ovh>
Date: Mon, 8 Jun 2015 13:11:44 +0200
Subject: [PATCH] Ajout d'un parametre pour retirer le driver bcm63xx-spi

---
 bcm63xx-phone/src/main.c    | 14 ++++++++++++++
 bcm63xx-phone/src/mpi/mpi.c | 20 +++++++++++++++++++-
 2 files changed, 33 insertions(+), 1 deletion(-)

diff --git a/bcm63xx-phone/src/main.c b/bcm63xx-phone/src/main.c
index 3a70b49..1a0c54e 100644
--- a/bcm63xx-phone/src/main.c
+++ b/bcm63xx-phone/src/main.c
@@ -68,6 +68,20 @@ module_param_named(channel_mapping, bcm_drv_param_channel_mapping, uint, 0);
 #endif // __KERNEL__
 #endif // !BCMPH_TEST_PCM

+#ifndef BCMPH_USE_SPI_DRIVER
+#ifdef __KERNEL__
+// This param is used to unregister driver named bcm63xx-spi that
+// conflicts with our own manager of SPI bus.
+// Beware that this operation can't be reversed.
+// It's a (quite dirty) workaround for the problem where bcm63xx-spi
+// driver is linked into the kernel (default with OpenWrt 14.07),
+// because in that case 'rmmod bcm63xx-spi' is not possible.
+bool bcm_drv_param_unregister_bcm63xx_spi = false;
+
+module_param_named(unregister_bcm63xx_spi, bcm_drv_param_unregister_bcm63xx_spi, bool, 0);
+#endif // __KERNEL__
+#endif // !BCMPH_USE_SPI_DRIVER
+
 // Callback called periodically by timer of phone_mgr
 static void bcm_drv_timer_cb(bcm_phone_mgr_t *phone_mgr)
 {
diff --git a/bcm63xx-phone/src/mpi/mpi.c b/bcm63xx-phone/src/mpi/mpi.c
index 1d39dd0..f1c5a6b 100644
--- a/bcm63xx-phone/src/mpi/mpi.c
+++ b/bcm63xx-phone/src/mpi/mpi.c
@@ -846,6 +846,10 @@ int bcm_mpi_read_write(bcm_mpi_t *t, __u8 *buf, __u8 buf_len)
    return (ret);
 }

+#ifndef BCMPH_USE_SPI_DRIVER
+extern bool bcm_drv_param_unregister_bcm63xx_spi;
+#endif // !BCMPH_USE_SPI_DRIVER
+
 int __init bcm_mpi_init(bcm_mpi_t *t, const bcm_mpi_params_t *params)
 {
    int ret = 0;
@@ -913,7 +917,21 @@ fail_master:
    t->wait_completion_with_irq = params->wait_completion_with_irq;

    if (bcm_mpi_dev_data.ref_count <= 0) {
-      ret = platform_driver_register(&(bcm63xx_spi_driver));
+      struct device_driver *spi_driver = driver_find(bcm63xx_spi_driver.driver.name, &platform_bus_type);
+      if (NULL != spi_driver) {
+         if (bcm_drv_param_unregister_bcm63xx_spi) {
+            driver_unregister(spi_driver);
+            spi_driver = NULL;
+         }
+         else {
+            bcm_pr_err("Error: Driver '%s' is already registered, aborting...\n",
+               bcm63xx_spi_driver.driver.name);
+            ret = -EBUSY;
+         }
+      }
+      if (NULL == spi_driver) {
+         ret = platform_driver_register(&(bcm63xx_spi_driver));
+      }
       bcm_assert(((ret) && (0 == bcm_mpi_dev_data.ref_count))
          || ((!ret) && (1 == bcm_mpi_dev_data.ref_count)));
    }
-- 
2.1.4
dotmark commented 9 years ago

I used "make kernel_menuconfig " and deselect "Device Drivers-->SPI Support-->Broadcom BCM63xx SPI controller" "Device Drivers-->SPI Support-->Broadcom BCM63xx HS SPI controller driver"

now "bcm63xx-phone" succeeded load.

pgid69 commented 9 years ago

Thank you for your feedback. When you have time, please let me know the results of your tests with Asterisk. I'd like to know if Asterisk channel and bcm63xx-phone works correctly on HW556.

pgid69 commented 9 years ago

I finally test the patch above and it does not work : unregistering the driver spi-bcm63xx causes a kernel oops, so i won't include this patch (moreover it was dirty solution). I will just include a more explicit message that bcm63xx-spi is already registered.