Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 1 | /* |
| 2 | * Copyright (C) 2007-2016 The Android Open Source Project |
| 3 | * |
| 4 | * Licensed under the Apache License, Version 2.0 (the "License"); |
| 5 | * you may not use this file except in compliance with the License. |
| 6 | * You may obtain a copy of the License at |
| 7 | * |
| 8 | * http://www.apache.org/licenses/LICENSE-2.0 |
| 9 | * |
| 10 | * Unless required by applicable law or agreed to in writing, software |
| 11 | * distributed under the License is distributed on an "AS IS" BASIS, |
| 12 | * WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied. |
| 13 | * See the License for the specific language governing permissions and |
| 14 | * limitations under the License. |
| 15 | */ |
| 16 | |
Tom Cherry | 21bb36c | 2020-01-08 15:18:26 -0800 | [diff] [blame] | 17 | #include "pmsg_writer.h" |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 18 | |
| 19 | #include <errno.h> |
| 20 | #include <fcntl.h> |
| 21 | #include <stdlib.h> |
| 22 | #include <string.h> |
| 23 | #include <sys/types.h> |
| 24 | #include <time.h> |
| 25 | |
Tom Cherry | 2a6811b | 2019-12-11 12:56:01 -0800 | [diff] [blame] | 26 | #include <shared_mutex> |
| 27 | |
Steven Moreland | 1f83aa4 | 2017-04-13 23:48:57 -0700 | [diff] [blame] | 28 | #include <log/log_properties.h> |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 29 | #include <private/android_logger.h> |
| 30 | |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 31 | #include "logger.h" |
Tom Cherry | 2a6811b | 2019-12-11 12:56:01 -0800 | [diff] [blame] | 32 | #include "rwlock.h" |
Tom Cherry | 6f6ef39 | 2019-01-16 14:17:08 -0800 | [diff] [blame] | 33 | #include "uio.h" |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 34 | |
Tom Cherry | 2a6811b | 2019-12-11 12:56:01 -0800 | [diff] [blame] | 35 | static int pmsg_fd; |
| 36 | static RwLock pmsg_fd_lock; |
Mark Salyzyn | db8a266 | 2016-10-10 07:27:42 -0700 | [diff] [blame] | 37 | |
Tom Cherry | 2a6811b | 2019-12-11 12:56:01 -0800 | [diff] [blame] | 38 | static void PmsgOpen() { |
| 39 | auto lock = std::unique_lock{pmsg_fd_lock}; |
| 40 | if (pmsg_fd > 0) { |
| 41 | // Someone raced us and opened the socket already. |
| 42 | return; |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 43 | } |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 44 | |
Tom Cherry | 2a6811b | 2019-12-11 12:56:01 -0800 | [diff] [blame] | 45 | pmsg_fd = TEMP_FAILURE_RETRY(open("/dev/pmsg0", O_WRONLY | O_CLOEXEC)); |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 46 | } |
| 47 | |
Tom Cherry | 21bb36c | 2020-01-08 15:18:26 -0800 | [diff] [blame] | 48 | void PmsgClose() { |
Tom Cherry | 2a6811b | 2019-12-11 12:56:01 -0800 | [diff] [blame] | 49 | auto lock = std::unique_lock{pmsg_fd_lock}; |
| 50 | if (pmsg_fd > 0) { |
| 51 | close(pmsg_fd); |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 52 | } |
Tom Cherry | 2a6811b | 2019-12-11 12:56:01 -0800 | [diff] [blame] | 53 | pmsg_fd = 0; |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 54 | } |
| 55 | |
Tom Cherry | 21bb36c | 2020-01-08 15:18:26 -0800 | [diff] [blame] | 56 | int PmsgWrite(log_id_t logId, struct timespec* ts, struct iovec* vec, size_t nr) { |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 57 | static const unsigned headerLength = 2; |
| 58 | struct iovec newVec[nr + headerLength]; |
| 59 | android_log_header_t header; |
| 60 | android_pmsg_log_header_t pmsgHeader; |
| 61 | size_t i, payloadSize; |
| 62 | ssize_t ret; |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 63 | |
Tom Cherry | 2a6811b | 2019-12-11 12:56:01 -0800 | [diff] [blame] | 64 | if (!__android_log_is_debuggable()) { |
| 65 | if (logId != LOG_ID_EVENTS && logId != LOG_ID_SECURITY) { |
| 66 | return -1; |
Mark Salyzyn | 7ef5249 | 2016-03-25 15:50:46 -0700 | [diff] [blame] | 67 | } |
| 68 | |
Tom Cherry | 2a6811b | 2019-12-11 12:56:01 -0800 | [diff] [blame] | 69 | if (logId == LOG_ID_EVENTS) { |
| 70 | if (vec[0].iov_len < 4) { |
| 71 | return -EINVAL; |
| 72 | } |
| 73 | |
| 74 | if (SNET_EVENT_LOG_TAG != *static_cast<uint32_t*>(vec[0].iov_base)) { |
| 75 | return -EPERM; |
| 76 | } |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 77 | } |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 78 | } |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 79 | |
Tom Cherry | 2a6811b | 2019-12-11 12:56:01 -0800 | [diff] [blame] | 80 | auto lock = std::shared_lock{pmsg_fd_lock}; |
| 81 | |
| 82 | if (pmsg_fd <= 0) { |
| 83 | lock.unlock(); |
| 84 | PmsgOpen(); |
| 85 | lock.lock(); |
| 86 | } |
| 87 | |
| 88 | if (pmsg_fd <= 0) { |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 89 | return -EBADF; |
| 90 | } |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 91 | |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 92 | /* |
| 93 | * struct { |
| 94 | * // what we provide to pstore |
| 95 | * android_pmsg_log_header_t pmsgHeader; |
| 96 | * // what we provide to file |
| 97 | * android_log_header_t header; |
| 98 | * // caller provides |
| 99 | * union { |
| 100 | * struct { |
| 101 | * char prio; |
| 102 | * char payload[]; |
| 103 | * } string; |
| 104 | * struct { |
| 105 | * uint32_t tag |
| 106 | * char payload[]; |
| 107 | * } binary; |
| 108 | * }; |
| 109 | * }; |
| 110 | */ |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 111 | |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 112 | pmsgHeader.magic = LOGGER_MAGIC; |
| 113 | pmsgHeader.len = sizeof(pmsgHeader) + sizeof(header); |
Tom Cherry | b47aa2a | 2020-01-08 15:34:14 -0800 | [diff] [blame] | 114 | pmsgHeader.uid = getuid(); |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 115 | pmsgHeader.pid = getpid(); |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 116 | |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 117 | header.id = logId; |
| 118 | header.tid = gettid(); |
| 119 | header.realtime.tv_sec = ts->tv_sec; |
| 120 | header.realtime.tv_nsec = ts->tv_nsec; |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 121 | |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 122 | newVec[0].iov_base = (unsigned char*)&pmsgHeader; |
| 123 | newVec[0].iov_len = sizeof(pmsgHeader); |
| 124 | newVec[1].iov_base = (unsigned char*)&header; |
| 125 | newVec[1].iov_len = sizeof(header); |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 126 | |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 127 | for (payloadSize = 0, i = headerLength; i < nr + headerLength; i++) { |
| 128 | newVec[i].iov_base = vec[i - headerLength].iov_base; |
| 129 | payloadSize += newVec[i].iov_len = vec[i - headerLength].iov_len; |
| 130 | |
| 131 | if (payloadSize > LOGGER_ENTRY_MAX_PAYLOAD) { |
| 132 | newVec[i].iov_len -= payloadSize - LOGGER_ENTRY_MAX_PAYLOAD; |
| 133 | if (newVec[i].iov_len) { |
| 134 | ++i; |
| 135 | } |
| 136 | payloadSize = LOGGER_ENTRY_MAX_PAYLOAD; |
| 137 | break; |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 138 | } |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 139 | } |
| 140 | pmsgHeader.len += payloadSize; |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 141 | |
Tom Cherry | 2a6811b | 2019-12-11 12:56:01 -0800 | [diff] [blame] | 142 | ret = TEMP_FAILURE_RETRY(writev(pmsg_fd, newVec, i)); |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 143 | if (ret < 0) { |
| 144 | ret = errno ? -errno : -ENOTCONN; |
| 145 | } |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 146 | |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 147 | if (ret > (ssize_t)(sizeof(header) + sizeof(pmsgHeader))) { |
| 148 | ret -= sizeof(header) - sizeof(pmsgHeader); |
| 149 | } |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 150 | |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 151 | return ret; |
Mark Salyzyn | 018a96d | 2016-03-01 13:45:42 -0800 | [diff] [blame] | 152 | } |
Mark Salyzyn | d4b061b | 2016-03-10 09:50:08 -0800 | [diff] [blame] | 153 | |
| 154 | /* |
| 155 | * Virtual pmsg filesystem |
| 156 | * |
| 157 | * Payload will comprise the string "<basedir>:<basefile>\0<content>" to a |
| 158 | * maximum of LOGGER_ENTRY_MAX_PAYLOAD, but scaled to the last newline in the |
| 159 | * file. |
| 160 | * |
| 161 | * Will hijack the header.realtime.tv_nsec field for a sequence number in usec. |
| 162 | */ |
| 163 | |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 164 | static inline const char* strnrchr(const char* buf, size_t len, char c) { |
| 165 | const char* cp = buf + len; |
| 166 | while ((--cp > buf) && (*cp != c)) |
| 167 | ; |
| 168 | if (cp <= buf) { |
| 169 | return buf + len; |
| 170 | } |
| 171 | return cp; |
Mark Salyzyn | d4b061b | 2016-03-10 09:50:08 -0800 | [diff] [blame] | 172 | } |
| 173 | |
| 174 | /* Write a buffer as filename references (tag = <basedir>:<basename>) */ |
Tom Cherry | 2d9779e | 2019-02-08 11:46:19 -0800 | [diff] [blame] | 175 | ssize_t __android_log_pmsg_file_write(log_id_t logId, char prio, const char* filename, |
| 176 | const char* buf, size_t len) { |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 177 | size_t length, packet_len; |
| 178 | const char* tag; |
| 179 | char *cp, *slash; |
| 180 | struct timespec ts; |
| 181 | struct iovec vec[3]; |
Mark Salyzyn | d4b061b | 2016-03-10 09:50:08 -0800 | [diff] [blame] | 182 | |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 183 | /* Make sure the logId value is not a bad idea */ |
| 184 | if ((logId == LOG_ID_KERNEL) || /* Verbotten */ |
| 185 | (logId == LOG_ID_EVENTS) || /* Do not support binary content */ |
| 186 | (logId == LOG_ID_SECURITY) || /* Bad idea to allow */ |
| 187 | ((unsigned)logId >= 32)) { /* fit within logMask on arch32 */ |
| 188 | return -EINVAL; |
| 189 | } |
Mark Salyzyn | d4b061b | 2016-03-10 09:50:08 -0800 | [diff] [blame] | 190 | |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 191 | clock_gettime(android_log_clockid(), &ts); |
Mark Salyzyn | d4b061b | 2016-03-10 09:50:08 -0800 | [diff] [blame] | 192 | |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 193 | cp = strdup(filename); |
| 194 | if (!cp) { |
| 195 | return -ENOMEM; |
| 196 | } |
Mark Salyzyn | d4b061b | 2016-03-10 09:50:08 -0800 | [diff] [blame] | 197 | |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 198 | tag = cp; |
| 199 | slash = strrchr(cp, '/'); |
| 200 | if (slash) { |
| 201 | *slash = ':'; |
Mark Salyzyn | d4b061b | 2016-03-10 09:50:08 -0800 | [diff] [blame] | 202 | slash = strrchr(cp, '/'); |
| 203 | if (slash) { |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 204 | tag = slash + 1; |
| 205 | } |
| 206 | } |
| 207 | |
| 208 | length = strlen(tag) + 1; |
| 209 | packet_len = LOGGER_ENTRY_MAX_PAYLOAD - sizeof(char) - length; |
| 210 | |
| 211 | vec[0].iov_base = &prio; |
| 212 | vec[0].iov_len = sizeof(char); |
| 213 | vec[1].iov_base = (unsigned char*)tag; |
| 214 | vec[1].iov_len = length; |
| 215 | |
Tom Cherry | 71ba164 | 2019-01-10 10:37:36 -0800 | [diff] [blame] | 216 | for (ts.tv_nsec = 0, length = len; length; ts.tv_nsec += ANDROID_LOG_PMSG_FILE_SEQUENCE) { |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 217 | ssize_t ret; |
| 218 | size_t transfer; |
| 219 | |
Tom Cherry | 71ba164 | 2019-01-10 10:37:36 -0800 | [diff] [blame] | 220 | if ((ts.tv_nsec / ANDROID_LOG_PMSG_FILE_SEQUENCE) >= ANDROID_LOG_PMSG_FILE_MAX_SEQUENCE) { |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 221 | len -= length; |
| 222 | break; |
Mark Salyzyn | d4b061b | 2016-03-10 09:50:08 -0800 | [diff] [blame] | 223 | } |
| 224 | |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 225 | transfer = length; |
| 226 | if (transfer > packet_len) { |
| 227 | transfer = strnrchr(buf, packet_len - 1, '\n') - buf; |
| 228 | if ((transfer < length) && (buf[transfer] == '\n')) { |
| 229 | ++transfer; |
| 230 | } |
Mark Salyzyn | d4b061b | 2016-03-10 09:50:08 -0800 | [diff] [blame] | 231 | } |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 232 | |
| 233 | vec[2].iov_base = (unsigned char*)buf; |
| 234 | vec[2].iov_len = transfer; |
| 235 | |
Tom Cherry | 2a6811b | 2019-12-11 12:56:01 -0800 | [diff] [blame] | 236 | ret = PmsgWrite(logId, &ts, vec, sizeof(vec) / sizeof(vec[0])); |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 237 | |
| 238 | if (ret <= 0) { |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 239 | free(cp); |
| 240 | return ret ? ret : (len - length); |
Mark Salyzyn | db8a266 | 2016-10-10 07:27:42 -0700 | [diff] [blame] | 241 | } |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 242 | length -= transfer; |
| 243 | buf += transfer; |
| 244 | } |
Mark Salyzyn | 2ed51d7 | 2017-03-09 08:09:43 -0800 | [diff] [blame] | 245 | free(cp); |
| 246 | return len; |
Mark Salyzyn | d4b061b | 2016-03-10 09:50:08 -0800 | [diff] [blame] | 247 | } |