179662672Smatthias.ringwald /* 2a0c35809S[email protected] * Copyright (C) 2014 BlueKitchen GmbH 31713bceaSmatthias.ringwald * 41713bceaSmatthias.ringwald * Redistribution and use in source and binary forms, with or without 51713bceaSmatthias.ringwald * modification, are permitted provided that the following conditions 61713bceaSmatthias.ringwald * are met: 71713bceaSmatthias.ringwald * 81713bceaSmatthias.ringwald * 1. Redistributions of source code must retain the above copyright 91713bceaSmatthias.ringwald * notice, this list of conditions and the following disclaimer. 101713bceaSmatthias.ringwald * 2. Redistributions in binary form must reproduce the above copyright 111713bceaSmatthias.ringwald * notice, this list of conditions and the following disclaimer in the 121713bceaSmatthias.ringwald * documentation and/or other materials provided with the distribution. 131713bceaSmatthias.ringwald * 3. Neither the name of the copyright holders nor the names of 141713bceaSmatthias.ringwald * contributors may be used to endorse or promote products derived 151713bceaSmatthias.ringwald * from this software without specific prior written permission. 166b64433eSmatthias.ringwald * 4. Any redistribution, use, or modification is done solely for 176b64433eSmatthias.ringwald * personal benefit and not for any commercial purpose or for 186b64433eSmatthias.ringwald * monetary gain. 191713bceaSmatthias.ringwald * 20a0c35809S[email protected] * THIS SOFTWARE IS PROVIDED BY BLUEKITCHEN GMBH AND CONTRIBUTORS 211713bceaSmatthias.ringwald * ``AS IS'' AND ANY EXPRESS OR IMPLIED WARRANTIES, INCLUDING, BUT NOT 221713bceaSmatthias.ringwald * LIMITED TO, THE IMPLIED WARRANTIES OF MERCHANTABILITY AND FITNESS 231713bceaSmatthias.ringwald * FOR A PARTICULAR PURPOSE ARE DISCLAIMED. IN NO EVENT SHALL MATTHIAS 241713bceaSmatthias.ringwald * RINGWALD OR CONTRIBUTORS BE LIABLE FOR ANY DIRECT, INDIRECT, 251713bceaSmatthias.ringwald * INCIDENTAL, SPECIAL, EXEMPLARY, OR CONSEQUENTIAL DAMAGES (INCLUDING, 261713bceaSmatthias.ringwald * BUT NOT LIMITED TO, PROCUREMENT OF SUBSTITUTE GOODS OR SERVICES; LOSS 271713bceaSmatthias.ringwald * OF USE, DATA, OR PROFITS; OR BUSINESS INTERRUPTION) HOWEVER CAUSED 281713bceaSmatthias.ringwald * AND ON ANY THEORY OF LIABILITY, WHETHER IN CONTRACT, STRICT LIABILITY, 291713bceaSmatthias.ringwald * OR TORT (INCLUDING NEGLIGENCE OR OTHERWISE) ARISING IN ANY WAY OUT OF 301713bceaSmatthias.ringwald * THE USE OF THIS SOFTWARE, EVEN IF ADVISED OF THE POSSIBILITY OF 311713bceaSmatthias.ringwald * SUCH DAMAGE. 321713bceaSmatthias.ringwald * 33a0c35809S[email protected] * Please inquire about commercial licensing options at 34a0c35809S[email protected] * [email protected] 356b64433eSmatthias.ringwald * 361713bceaSmatthias.ringwald */ 371713bceaSmatthias.ringwald 381713bceaSmatthias.ringwald /* 3979662672Smatthias.ringwald * hci_dump.c 4079662672Smatthias.ringwald * 41fe1ed1b8Smatthias.ringwald * Dump HCI trace in various formats: 42fe1ed1b8Smatthias.ringwald * 43fe1ed1b8Smatthias.ringwald * - BlueZ's hcidump format 44fe1ed1b8Smatthias.ringwald * - Apple's PacketLogger 45fe1ed1b8Smatthias.ringwald * - stdout hexdump 4679662672Smatthias.ringwald * 4779662672Smatthias.ringwald * Created by Matthias Ringwald on 5/26/09. 4879662672Smatthias.ringwald */ 4979662672Smatthias.ringwald 50bde315ceS[email protected] #include "btstack-config.h" 51a1d7dd1fSmatthias.ringwald 5279662672Smatthias.ringwald #include "hci_dump.h" 5379662672Smatthias.ringwald #include "hci.h" 54c6448b67Smatthias.ringwald #include "hci_transport.h" 55a1d7dd1fSmatthias.ringwald #include <btstack/hci_cmds.h> 561df3b679S[email protected] #include <btstack/run_loop.h> 57198a9e1bS[email protected] #include <stdio.h> 5879662672Smatthias.ringwald 5968e27c0fSmatthias.ringwald #ifndef EMBEDDED 60d5ea8924S[email protected] #include <fcntl.h> // open 6179662672Smatthias.ringwald #include <unistd.h> // write 628adf0ddaSmatthias.ringwald #include <time.h> 638b658ebcSmatthias.ringwald #include <sys/time.h> // for timestamps 64c7b9c559Smatthias.ringwald #include <sys/stat.h> // for mode flags 65a1d7dd1fSmatthias.ringwald #include <stdarg.h> // for va_list 6668e27c0fSmatthias.ringwald #endif 6779662672Smatthias.ringwald 688b658ebcSmatthias.ringwald // BLUEZ hcidump 698b658ebcSmatthias.ringwald typedef struct { 708b658ebcSmatthias.ringwald uint16_t len; 718b658ebcSmatthias.ringwald uint8_t in; 728b658ebcSmatthias.ringwald uint8_t pad; 738b658ebcSmatthias.ringwald uint32_t ts_sec; 748b658ebcSmatthias.ringwald uint32_t ts_usec; 758b658ebcSmatthias.ringwald uint8_t packet_type; 766c5c6faaSmatthias.ringwald } 776c5c6faaSmatthias.ringwald #ifdef __GNUC__ 786c5c6faaSmatthias.ringwald __attribute__ ((packed)) 796c5c6faaSmatthias.ringwald #endif 806c5c6faaSmatthias.ringwald hcidump_hdr; 8179662672Smatthias.ringwald 828b658ebcSmatthias.ringwald // APPLE PacketLogger 838b658ebcSmatthias.ringwald typedef struct { 848b658ebcSmatthias.ringwald uint32_t len; 858b658ebcSmatthias.ringwald uint32_t ts_sec; 868b658ebcSmatthias.ringwald uint32_t ts_usec; 872df12229Smatthias.ringwald uint8_t type; // 0xfc for note 886c5c6faaSmatthias.ringwald } 896c5c6faaSmatthias.ringwald #ifdef __GNUC__ 906c5c6faaSmatthias.ringwald __attribute__ ((packed)) 916c5c6faaSmatthias.ringwald #endif 926c5c6faaSmatthias.ringwald pktlog_hdr; 938b658ebcSmatthias.ringwald 948b658ebcSmatthias.ringwald static int dump_file = -1; 95198a9e1bS[email protected] #ifndef EMBEDDED 968b658ebcSmatthias.ringwald static int dump_format; 978b658ebcSmatthias.ringwald static hcidump_hdr header_bluez; 988b658ebcSmatthias.ringwald static pktlog_hdr header_packetlogger; 998adf0ddaSmatthias.ringwald static char time_string[40]; 1002992c131Smatthias.ringwald static int max_nr_packets = -1; 1019ae0c346Smatthias.ringwald static int nr_packets = 0; 102a1d7dd1fSmatthias.ringwald static char log_message_buffer[256]; 10368e27c0fSmatthias.ringwald #endif 1048b658ebcSmatthias.ringwald 105a225073eS[email protected] void hci_dump_open(const char *filename, hci_dump_format_t format){ 106198a9e1bS[email protected] #ifdef EMBEDDED 107198a9e1bS[email protected] dump_file = 1; 108198a9e1bS[email protected] #else 1098b658ebcSmatthias.ringwald dump_format = format; 1108adf0ddaSmatthias.ringwald if (dump_format == HCI_DUMP_STDOUT) { 1118adf0ddaSmatthias.ringwald dump_file = fileno(stdout); 1128adf0ddaSmatthias.ringwald } else { 113b52eaea5S[email protected] #ifdef _WIN32 114b52eaea5S[email protected] dump_file = open(filename, O_WRONLY | O_CREAT | O_TRUNC); 115b52eaea5S[email protected] #else 1168adf0ddaSmatthias.ringwald dump_file = open(filename, O_WRONLY | O_CREAT | O_TRUNC, S_IRUSR | S_IWUSR | S_IRGRP | S_IROTH); 117b52eaea5S[email protected] #endif 11879662672Smatthias.ringwald } 11968e27c0fSmatthias.ringwald #endif 120d9659922Smatthias.ringwald } 12179662672Smatthias.ringwald 1227c5f7483Smatthias.ringwald #ifndef EMBEDDED 1232992c131Smatthias.ringwald void hci_dump_set_max_packets(int packets){ 1242992c131Smatthias.ringwald max_nr_packets = packets; 1252992c131Smatthias.ringwald } 1267c5f7483Smatthias.ringwald #endif 1272992c131Smatthias.ringwald 128198a9e1bS[email protected] static inline void printf_packet(uint8_t packet_type, uint8_t in, uint8_t * packet, uint16_t len){ 129198a9e1bS[email protected] switch (packet_type){ 130198a9e1bS[email protected] case HCI_COMMAND_DATA_PACKET: 131198a9e1bS[email protected] printf("CMD => "); 132198a9e1bS[email protected] break; 133198a9e1bS[email protected] case HCI_EVENT_PACKET: 134198a9e1bS[email protected] printf("EVT <= "); 135198a9e1bS[email protected] break; 136198a9e1bS[email protected] case HCI_ACL_DATA_PACKET: 137198a9e1bS[email protected] if (in) { 138198a9e1bS[email protected] printf("ACL <= "); 139198a9e1bS[email protected] } else { 140198a9e1bS[email protected] printf("ACL => "); 141198a9e1bS[email protected] } 142198a9e1bS[email protected] break; 143198a9e1bS[email protected] case LOG_MESSAGE_PACKET: 144198a9e1bS[email protected] printf("LOG -- %s\n", (char*) packet); 145198a9e1bS[email protected] return; 146198a9e1bS[email protected] default: 147198a9e1bS[email protected] return; 148198a9e1bS[email protected] } 149198a9e1bS[email protected] printf_hexdump(packet, len); 150198a9e1bS[email protected] } 151198a9e1bS[email protected] 15279662672Smatthias.ringwald void hci_dump_packet(uint8_t packet_type, uint8_t in, uint8_t *packet, uint16_t len) { 15368e27c0fSmatthias.ringwald 1548b658ebcSmatthias.ringwald if (dump_file < 0) return; // not activated yet 1558b658ebcSmatthias.ringwald 156198a9e1bS[email protected] #ifdef EMBEDDED 1571df3b679S[email protected] // #ifdef HAVE_TICK 1581df3b679S[email protected] // uint32_t time_ms = embedded_get_time_ms(); 1591df3b679S[email protected] // printf("[%06u] ", time_ms); 1601df3b679S[email protected] // #endif 161198a9e1bS[email protected] printf_packet(packet_type, in, packet, len); 162198a9e1bS[email protected] #else 1632992c131Smatthias.ringwald // don't grow bigger than max_nr_packets 1642992c131Smatthias.ringwald if (dump_format != HCI_DUMP_STDOUT && max_nr_packets > 0){ 1652992c131Smatthias.ringwald if (nr_packets >= max_nr_packets){ 1662992c131Smatthias.ringwald lseek(dump_file, 0, SEEK_SET); 1672992c131Smatthias.ringwald ftruncate(dump_file, 0); 1682992c131Smatthias.ringwald nr_packets = 0; 1692992c131Smatthias.ringwald } 1702992c131Smatthias.ringwald nr_packets++; 1712992c131Smatthias.ringwald } 1722992c131Smatthias.ringwald 1738b658ebcSmatthias.ringwald // get time 1748b658ebcSmatthias.ringwald struct timeval curr_time; 1758adf0ddaSmatthias.ringwald struct tm* ptm; 1768b658ebcSmatthias.ringwald gettimeofday(&curr_time, NULL); 177d5ea8924S[email protected] time_t curr_time_secs = curr_time.tv_sec; 1788b658ebcSmatthias.ringwald 1798b658ebcSmatthias.ringwald switch (dump_format){ 180a9cf4d77S[email protected] case HCI_DUMP_STDOUT: { 1818adf0ddaSmatthias.ringwald /* Obtain the time of day, and convert it to a tm struct. */ 182d5ea8924S[email protected] ptm = localtime (&curr_time_secs); 1838adf0ddaSmatthias.ringwald /* Format the date and time, down to a single second. */ 1848adf0ddaSmatthias.ringwald strftime (time_string, sizeof (time_string), "[%Y-%m-%d %H:%M:%S", ptm); 1858adf0ddaSmatthias.ringwald /* Compute milliseconds from microseconds. */ 1868adf0ddaSmatthias.ringwald uint16_t milliseconds = curr_time.tv_usec / 1000; 1878adf0ddaSmatthias.ringwald /* Print the formatted time, in seconds, followed by a decimal point 1888adf0ddaSmatthias.ringwald and the milliseconds. */ 1898adf0ddaSmatthias.ringwald printf ("%s.%03u] ", time_string, milliseconds); 190198a9e1bS[email protected] printf_packet(packet_type, in, packet, len); 1918adf0ddaSmatthias.ringwald break; 192a9cf4d77S[email protected] } 1930d79c710Smatthias.ringwald 1948b658ebcSmatthias.ringwald case HCI_DUMP_BLUEZ: 1958b658ebcSmatthias.ringwald bt_store_16( (uint8_t *) &header_bluez.len, 0, 1 + len); 1968b658ebcSmatthias.ringwald header_bluez.in = in; 1978b658ebcSmatthias.ringwald header_bluez.pad = 0; 1988b658ebcSmatthias.ringwald bt_store_32( (uint8_t *) &header_bluez.ts_sec, 0, curr_time.tv_sec); 1998b658ebcSmatthias.ringwald bt_store_32( (uint8_t *) &header_bluez.ts_usec, 0, curr_time.tv_usec); 2008b658ebcSmatthias.ringwald header_bluez.packet_type = packet_type; 2018b658ebcSmatthias.ringwald write (dump_file, &header_bluez, sizeof(hcidump_hdr) ); 20279662672Smatthias.ringwald write (dump_file, packet, len ); 2038b658ebcSmatthias.ringwald break; 2040d79c710Smatthias.ringwald 2058b658ebcSmatthias.ringwald case HCI_DUMP_PACKETLOGGER: 206b52eaea5S[email protected] net_store_32( (uint8_t *) &header_packetlogger, 0, sizeof(pktlog_hdr) - 4 + len); 207b52eaea5S[email protected] net_store_32( (uint8_t *) &header_packetlogger, 4, curr_time.tv_sec); 208b52eaea5S[email protected] net_store_32( (uint8_t *) &header_packetlogger, 8, curr_time.tv_usec); 2098b658ebcSmatthias.ringwald switch (packet_type){ 2108b658ebcSmatthias.ringwald case HCI_COMMAND_DATA_PACKET: 2118b658ebcSmatthias.ringwald header_packetlogger.type = 0x00; 2128b658ebcSmatthias.ringwald break; 2138b658ebcSmatthias.ringwald case HCI_ACL_DATA_PACKET: 2148b658ebcSmatthias.ringwald if (in) { 2158b658ebcSmatthias.ringwald header_packetlogger.type = 0x03; 2168b658ebcSmatthias.ringwald } else { 2178b658ebcSmatthias.ringwald header_packetlogger.type = 0x02; 2188b658ebcSmatthias.ringwald } 2198b658ebcSmatthias.ringwald break; 2208d675e3dS[email protected] case HCI_SCO_DATA_PACKET: 2218d675e3dS[email protected] if (in) { 2228d675e3dS[email protected] header_packetlogger.type = 0x09; 2238d675e3dS[email protected] } else { 2248d675e3dS[email protected] header_packetlogger.type = 0x08; 2258d675e3dS[email protected] } 2268d675e3dS[email protected] break; 2278b658ebcSmatthias.ringwald case HCI_EVENT_PACKET: 2288b658ebcSmatthias.ringwald header_packetlogger.type = 0x01; 2298b658ebcSmatthias.ringwald break; 2300d79c710Smatthias.ringwald case LOG_MESSAGE_PACKET: 2310d79c710Smatthias.ringwald header_packetlogger.type = 0xfc; 2320d79c710Smatthias.ringwald break; 2338b658ebcSmatthias.ringwald default: 2348b658ebcSmatthias.ringwald return; 2358b658ebcSmatthias.ringwald } 2368b658ebcSmatthias.ringwald write (dump_file, &header_packetlogger, sizeof(pktlog_hdr) ); 2378b658ebcSmatthias.ringwald write (dump_file, packet, len ); 2380d79c710Smatthias.ringwald break; 2390d79c710Smatthias.ringwald 2400d79c710Smatthias.ringwald default: 2410d79c710Smatthias.ringwald break; 2428b658ebcSmatthias.ringwald } 24368e27c0fSmatthias.ringwald #endif 24479662672Smatthias.ringwald } 24579662672Smatthias.ringwald 246a1d7dd1fSmatthias.ringwald void hci_dump_log(const char * format, ...){ 2471df3b679S[email protected] if (dump_file < 0) return; // not activated yet 248a1d7dd1fSmatthias.ringwald va_list argptr; 249a1d7dd1fSmatthias.ringwald va_start(argptr, format); 2501df3b679S[email protected] #ifdef EMBEDDED 2511df3b679S[email protected] printf("LOG -- "); 2521df3b679S[email protected] vprintf(format, argptr); 2531fd51e45S[email protected] printf("\n"); 2541df3b679S[email protected] #else 255a1d7dd1fSmatthias.ringwald int len = vsnprintf(log_message_buffer, sizeof(log_message_buffer), format, argptr); 256a1d7dd1fSmatthias.ringwald hci_dump_packet(LOG_MESSAGE_PACKET, 0, (uint8_t*) log_message_buffer, len); 257a1d7dd1fSmatthias.ringwald #endif 2581df3b679S[email protected] va_end(argptr); 259a1d7dd1fSmatthias.ringwald } 260a1d7dd1fSmatthias.ringwald 26120ea11b9S[email protected] #ifdef __AVR__ 26220ea11b9S[email protected] void hci_dump_log_P(PGM_P format, ...){ 26320ea11b9S[email protected] if (dump_file < 0) return; // not activated yet 26420ea11b9S[email protected] va_list argptr; 26520ea11b9S[email protected] va_start(argptr, format); 26620ea11b9S[email protected] printf_P(PSTR("LOG -- ")); 26720ea11b9S[email protected] vfprintf_P(stdout, format, argptr); 26820ea11b9S[email protected] printf_P(PSTR("\n")); 26920ea11b9S[email protected] va_end(argptr); 27020ea11b9S[email protected] } 27120ea11b9S[email protected] #endif 27220ea11b9S[email protected] 273*71de195eSMatthias Ringwald void hci_dump_close(void){ 27468e27c0fSmatthias.ringwald #ifndef EMBEDDED 27579662672Smatthias.ringwald close(dump_file); 276d9659922Smatthias.ringwald dump_file = -1; 27768e27c0fSmatthias.ringwald #endif 27879662672Smatthias.ringwald } 27979662672Smatthias.ringwald 280